builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-032 starttime: 1460501953.18 results: success (0) buildid: 20160412151348 builduid: 1c4de7b74d2b49aabb61200b3bf25527 revision: f6241b9dc0e90b1a7b418142c3a12202ebfc0df4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-12 15:59:13.178756) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-12 15:59:13.179192) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-12 15:59:13.179485) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1460501829.630477-1507377035 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006479 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-12 15:59:13.208387) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-12 15:59:13.208697) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-12 15:59:13.224698) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 15:59:13.224959) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1460501829.630477-1507377035 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004607 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 15:59:13.273458) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-12 15:59:13.273720) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-12 15:59:13.274050) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 15:59:13.274332) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1460501829.630477-1507377035 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-12 15:59:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 232M=0s 2016-04-12 15:59:13 (232 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.111129 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 15:59:13.397366) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 15:59:13.397643) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1460501829.630477-1507377035 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022816 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 15:59:13.446701) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 15:59:13.447045) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f6241b9dc0e90b1a7b418142c3a12202ebfc0df4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev f6241b9dc0e90b1a7b418142c3a12202ebfc0df4 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1460501829.630477-1507377035 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-12 15:59:13,604 truncating revision to first 12 chars 2016-04-12 15:59:13,605 Setting DEBUG logging. 2016-04-12 15:59:13,605 attempt 1/10 2016-04-12 15:59:13,605 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f6241b9dc0e9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-12 15:59:13,877 unpacking tar archive at: fx-team-f6241b9dc0e9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.538629 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 15:59:13.997958) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-12 15:59:13.998273) ========= echo f6241b9dc0e90b1a7b418142c3a12202ebfc0df4 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'f6241b9dc0e90b1a7b418142c3a12202ebfc0df4'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1460501829.630477-1507377035 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False f6241b9dc0e90b1a7b418142c3a12202ebfc0df4 program finished with exit code 0 elapsedTime=0.003862 script_repo_revision: 'f6241b9dc0e90b1a7b418142c3a12202ebfc0df4' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-12 15:59:14.046255) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-12 15:59:14.046589) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-12 15:59:14.058397) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-04-12 15:59:14.058683) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1460501829.630477-1507377035 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:59:14 INFO - MultiFileLogger online at 20160412 15:59:14 in /builds/slave/test 15:59:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 15:59:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:59:14 INFO - {'append_to_log': False, 15:59:14 INFO - 'base_work_dir': '/builds/slave/test', 15:59:14 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:59:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:59:14 INFO - 'branch': 'Fx-Team-Non-PGO', 15:59:14 INFO - 'buildbot_json_path': 'buildprops.json', 15:59:14 INFO - 'config_files': ('talos/linux_config.py',), 15:59:14 INFO - 'default_actions': ('clobber', 15:59:14 INFO - 'read-buildbot-config', 15:59:14 INFO - 'download-and-extract', 15:59:14 INFO - 'populate-webroot', 15:59:14 INFO - 'create-virtualenv', 15:59:14 INFO - 'install', 15:59:14 INFO - 'run-tests'), 15:59:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:59:14 INFO - 'download_minidump_stackwalk': True, 15:59:14 INFO - 'download_symbols': 'ondemand', 15:59:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:59:14 INFO - 'tooltool.py': '/tools/tooltool.py', 15:59:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:59:14 INFO - '/tools/misc-python/virtualenv.py')}, 15:59:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:59:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:59:14 INFO - 'installer_path': 'installer.exe', 15:59:14 INFO - 'log_level': 'info', 15:59:14 INFO - 'log_name': 'talos', 15:59:14 INFO - 'log_to_console': True, 15:59:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:59:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:59:14 INFO - 'opt_config_files': (), 15:59:14 INFO - 'pip_index': False, 15:59:14 INFO - 'sps_profile': False, 15:59:14 INFO - 'sps_profile_interval': 0, 15:59:14 INFO - 'suite': 'dromaeojs-e10s', 15:59:14 INFO - 'system_bits': '32', 15:59:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:59:14 INFO - 'title': 'talos-linux64-ix-032', 15:59:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:59:14 INFO - 'use_talos_json': True, 15:59:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:59:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:59:14 INFO - 'work_dir': 'build'} 15:59:14 INFO - ##### 15:59:14 INFO - ##### Running clobber step. 15:59:14 INFO - ##### 15:59:14 INFO - Running pre-action listener: _resource_record_pre_action 15:59:14 INFO - Running main action method: clobber 15:59:14 INFO - rmtree: /builds/slave/test/build 15:59:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:59:14 INFO - Running post-action listener: _resource_record_post_action 15:59:14 INFO - ##### 15:59:14 INFO - ##### Running read-buildbot-config step. 15:59:14 INFO - ##### 15:59:14 INFO - Running pre-action listener: _resource_record_pre_action 15:59:14 INFO - Running main action method: read_buildbot_config 15:59:14 INFO - Using buildbot properties: 15:59:14 INFO - { 15:59:14 INFO - "project": "", 15:59:14 INFO - "product": "firefox", 15:59:14 INFO - "script_repo_revision": "production", 15:59:14 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 15:59:14 INFO - "repository": "", 15:59:14 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 15:59:14 INFO - "buildid": "20160412151348", 15:59:14 INFO - "pgo_build": "False", 15:59:14 INFO - "basedir": "/builds/slave/test", 15:59:14 INFO - "buildnumber": 1395, 15:59:14 INFO - "slavename": "talos-linux64-ix-032", 15:59:14 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:59:14 INFO - "platform": "ubuntu64_hw", 15:59:14 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:59:14 INFO - "branch": "fx-team", 15:59:14 INFO - "repo_path": "integration/fx-team", 15:59:14 INFO - "revision": "f6241b9dc0e90b1a7b418142c3a12202ebfc0df4", 15:59:14 INFO - "stage_platform": "linux64", 15:59:14 INFO - "builduid": "1c4de7b74d2b49aabb61200b3bf25527", 15:59:14 INFO - "slavebuilddir": "test" 15:59:14 INFO - } 15:59:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 15:59:14 INFO - Running post-action listener: _resource_record_post_action 15:59:14 INFO - ##### 15:59:14 INFO - ##### Running download-and-extract step. 15:59:14 INFO - ##### 15:59:14 INFO - Running pre-action listener: _resource_record_pre_action 15:59:14 INFO - Running main action method: download_and_extract 15:59:14 INFO - mkdir: /builds/slave/test/build/tests 15:59:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:14 INFO - https://queue.taskcluster.net/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:59:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:59:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:59:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:59:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:59:15 INFO - Downloaded 1361 bytes. 15:59:15 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 15:59:15 INFO - Using the following test package requirements: 15:59:15 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 15:59:15 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:59:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:59:15 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:59:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:59:15 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:59:15 INFO - u'jsshell-linux-x86_64.zip'], 15:59:15 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:59:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:59:15 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 15:59:15 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:59:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:59:15 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:59:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:59:15 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:59:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:59:15 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 15:59:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:59:15 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:59:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:15 INFO - https://queue.taskcluster.net/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:59:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:59:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:59:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:59:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:59:17 INFO - Downloaded 22192969 bytes. 15:59:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:59:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:59:18 INFO - Return code: 0 15:59:18 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:59:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:18 INFO - https://queue.taskcluster.net/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:59:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:59:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:59:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 15:59:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:59:24 INFO - Downloaded 22192969 bytes. 15:59:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:59:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:59:25 INFO - Return code: 0 15:59:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:25 INFO - https://queue.taskcluster.net/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:59:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 15:59:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 15:59:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 15:59:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:59:27 INFO - Downloaded 10841076 bytes. 15:59:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:59:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 15:59:27 INFO - Return code: 0 15:59:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:27 INFO - https://queue.taskcluster.net/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:59:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:59:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:59:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:59:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:59:29 INFO - Downloaded 54147441 bytes. 15:59:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:59:29 INFO - mkdir: /builds/slave/test/properties 15:59:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:59:29 INFO - Writing to file /builds/slave/test/properties/build_url 15:59:29 INFO - Contents: 15:59:29 INFO - build_url:https://queue.taskcluster.net/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 15:59:30 INFO - Running post-action listener: _resource_record_post_action 15:59:30 INFO - Running post-action listener: set_extra_try_arguments 15:59:30 INFO - ##### 15:59:30 INFO - ##### Running populate-webroot step. 15:59:30 INFO - ##### 15:59:30 INFO - Running pre-action listener: _resource_record_pre_action 15:59:30 INFO - Running main action method: populate_webroot 15:59:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:59:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:59:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:59:30 INFO - '--tppagecycles', 15:59:30 INFO - '7'], 15:59:30 INFO - 'tests': ['tsvgm']}}, 15:59:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:59:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:59:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:59:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:59:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:59:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:59:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:30 INFO - 'talos_options': ['--disable-e10s'], 15:59:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:59:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:59:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:30 INFO - 'talos_options': ['--disable-e10s'], 15:59:30 INFO - 'tests': ['damp', 'tps']}, 15:59:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:30 INFO - 'tests': ['damp', 'tps']}, 15:59:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:59:30 INFO - 'tests': ['dromaeo_dom']}, 15:59:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:59:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:59:30 INFO - 'tests': ['a11yr', 15:59:30 INFO - 'ts_paint', 15:59:30 INFO - 'tpaint', 15:59:30 INFO - 'sessionrestore', 15:59:30 INFO - 'sessionrestore_no_auto_restore', 15:59:30 INFO - 'tabpaint']}, 15:59:30 INFO - 'other-e10s': {'tests': ['a11yr', 15:59:30 INFO - 'ts_paint', 15:59:30 INFO - 'tpaint', 15:59:30 INFO - 'sessionrestore', 15:59:30 INFO - 'sessionrestore_no_auto_restore', 15:59:30 INFO - 'tabpaint']}, 15:59:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:59:30 INFO - 'ts_paint', 15:59:30 INFO - 'tpaint', 15:59:30 INFO - 'sessionrestore', 15:59:30 INFO - 'sessionrestore_no_auto_restore', 15:59:30 INFO - 'tabpaint']}, 15:59:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:59:30 INFO - 'ts_paint', 15:59:30 INFO - 'tpaint', 15:59:30 INFO - 'sessionrestore', 15:59:30 INFO - 'sessionrestore_no_auto_restore', 15:59:30 INFO - 'tabpaint']}, 15:59:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:59:30 INFO - 'tests': ['a11yr', 15:59:30 INFO - 'ts_paint', 15:59:30 INFO - 'tpaint', 15:59:30 INFO - 'sessionrestore', 15:59:30 INFO - 'sessionrestore_no_auto_restore', 15:59:30 INFO - 'tabpaint']}, 15:59:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:59:30 INFO - 'tests': ['a11yr', 15:59:30 INFO - 'ts_paint', 15:59:30 INFO - 'tpaint', 15:59:30 INFO - 'sessionrestore', 15:59:30 INFO - 'sessionrestore_no_auto_restore', 15:59:30 INFO - 'tabpaint']}, 15:59:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:59:30 INFO - 'tests': ['tsvgx', 15:59:30 INFO - 'tsvgr_opacity', 15:59:30 INFO - 'tart', 15:59:30 INFO - 'tscrollx', 15:59:30 INFO - 'cart']}, 15:59:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:59:30 INFO - 'tsvgr_opacity', 15:59:30 INFO - 'tart', 15:59:30 INFO - 'tscrollx', 15:59:30 INFO - 'cart']}, 15:59:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:30 INFO - 'talos_options': ['--disable-e10s'], 15:59:30 INFO - 'tests': ['tp5o']}, 15:59:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:30 INFO - 'tests': ['tp5o']}, 15:59:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:30 INFO - 'talos_options': ['--disable-e10s', 15:59:30 INFO - '--xperf_path', 15:59:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:59:30 INFO - 'tests': ['tp5n']}, 15:59:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:30 INFO - 'talos_options': ['--xperf_path', 15:59:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:59:30 INFO - 'tests': ['tp5n']}}, 15:59:30 INFO - 'talos.zip': {'path': '', 15:59:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:59:30 INFO - Running post-action listener: _resource_record_post_action 15:59:30 INFO - ##### 15:59:30 INFO - ##### Running create-virtualenv step. 15:59:30 INFO - ##### 15:59:30 INFO - Running pre-action listener: _resource_record_pre_action 15:59:30 INFO - Running main action method: create_virtualenv 15:59:30 INFO - Creating virtualenv /builds/slave/test/build/venv 15:59:30 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:59:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:59:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:59:30 INFO - Using real prefix '/usr' 15:59:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:59:30 INFO - Installing distribute.............................................................................................................................................................................................done. 15:59:32 INFO - Installing pip.................done. 15:59:32 INFO - Return code: 0 15:59:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:59:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5b0e7e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a51410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a52310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a527a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1460501829.630477-1507377035', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:59:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:59:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:59:32 INFO - Using env: {'DISPLAY': ':0', 15:59:32 INFO - 'HOME': '/home/cltbld', 15:59:32 INFO - 'LANG': 'en_US.UTF-8', 15:59:32 INFO - 'LANGUAGE': 'en_US:en', 15:59:32 INFO - 'LOGNAME': 'cltbld', 15:59:32 INFO - 'MAIL': '/var/mail/cltbld', 15:59:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:32 INFO - 'MOZ_NO_REMOTE': '1', 15:59:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:32 INFO - 'NO_EM_RESTART': '1', 15:59:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:32 INFO - 'PWD': '/builds/slave/test', 15:59:32 INFO - 'SHELL': '/bin/bash', 15:59:32 INFO - 'SHLVL': '1', 15:59:32 INFO - 'TERM': 'linux', 15:59:32 INFO - 'TMOUT': '86400', 15:59:32 INFO - 'USER': 'cltbld', 15:59:32 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1460501829.630477-1507377035', 15:59:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:32 INFO - '_': '/tools/buildbot/bin/python'} 15:59:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:33 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:59:33 INFO - Cleaning up... 15:59:33 INFO - Return code: 0 15:59:33 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:59:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5b0e7e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a51410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a52310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a527a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1460501829.630477-1507377035', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:59:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 15:59:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 15:59:33 INFO - Using env: {'DISPLAY': ':0', 15:59:33 INFO - 'HOME': '/home/cltbld', 15:59:33 INFO - 'LANG': 'en_US.UTF-8', 15:59:33 INFO - 'LANGUAGE': 'en_US:en', 15:59:33 INFO - 'LOGNAME': 'cltbld', 15:59:33 INFO - 'MAIL': '/var/mail/cltbld', 15:59:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:33 INFO - 'MOZ_NO_REMOTE': '1', 15:59:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:33 INFO - 'NO_EM_RESTART': '1', 15:59:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:33 INFO - 'PWD': '/builds/slave/test', 15:59:33 INFO - 'SHELL': '/bin/bash', 15:59:33 INFO - 'SHLVL': '1', 15:59:33 INFO - 'TERM': 'linux', 15:59:33 INFO - 'TMOUT': '86400', 15:59:33 INFO - 'USER': 'cltbld', 15:59:33 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1460501829.630477-1507377035', 15:59:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:33 INFO - '_': '/tools/buildbot/bin/python'} 15:59:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:33 INFO - Downloading/unpacking psutil>=0.7.1 15:59:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:59:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:59:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:59:35 INFO - Installing collected packages: psutil 15:59:35 INFO - Running setup.py install for psutil 15:59:35 INFO - building 'psutil._psutil_linux' extension 15:59:35 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:59:35 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:59:35 INFO - building 'psutil._psutil_posix' extension 15:59:35 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:59:35 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:59:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:59:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:59:35 INFO - Successfully installed psutil 15:59:35 INFO - Cleaning up... 15:59:35 INFO - Return code: 0 15:59:35 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:59:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5b0e7e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a51410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a52310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a527a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1460501829.630477-1507377035', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:59:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 15:59:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 15:59:35 INFO - Using env: {'DISPLAY': ':0', 15:59:35 INFO - 'HOME': '/home/cltbld', 15:59:35 INFO - 'LANG': 'en_US.UTF-8', 15:59:35 INFO - 'LANGUAGE': 'en_US:en', 15:59:35 INFO - 'LOGNAME': 'cltbld', 15:59:35 INFO - 'MAIL': '/var/mail/cltbld', 15:59:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:35 INFO - 'MOZ_NO_REMOTE': '1', 15:59:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:35 INFO - 'NO_EM_RESTART': '1', 15:59:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:35 INFO - 'PWD': '/builds/slave/test', 15:59:35 INFO - 'SHELL': '/bin/bash', 15:59:35 INFO - 'SHLVL': '1', 15:59:35 INFO - 'TERM': 'linux', 15:59:35 INFO - 'TMOUT': '86400', 15:59:35 INFO - 'USER': 'cltbld', 15:59:35 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1460501829.630477-1507377035', 15:59:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:35 INFO - '_': '/tools/buildbot/bin/python'} 15:59:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:36 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:37 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:59:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:59:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:59:37 INFO - Installing collected packages: mozsystemmonitor 15:59:37 INFO - Running setup.py install for mozsystemmonitor 15:59:38 INFO - Successfully installed mozsystemmonitor 15:59:38 INFO - Cleaning up... 15:59:38 INFO - Return code: 0 15:59:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:59:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5b0e7e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a51410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a52310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a527a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1460501829.630477-1507377035', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:59:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:59:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:59:38 INFO - Using env: {'DISPLAY': ':0', 15:59:38 INFO - 'HOME': '/home/cltbld', 15:59:38 INFO - 'LANG': 'en_US.UTF-8', 15:59:38 INFO - 'LANGUAGE': 'en_US:en', 15:59:38 INFO - 'LOGNAME': 'cltbld', 15:59:38 INFO - 'MAIL': '/var/mail/cltbld', 15:59:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:38 INFO - 'MOZ_NO_REMOTE': '1', 15:59:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:38 INFO - 'NO_EM_RESTART': '1', 15:59:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:38 INFO - 'PWD': '/builds/slave/test', 15:59:38 INFO - 'SHELL': '/bin/bash', 15:59:38 INFO - 'SHLVL': '1', 15:59:38 INFO - 'TERM': 'linux', 15:59:38 INFO - 'TMOUT': '86400', 15:59:38 INFO - 'USER': 'cltbld', 15:59:38 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1460501829.630477-1507377035', 15:59:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:38 INFO - '_': '/tools/buildbot/bin/python'} 15:59:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:38 INFO - Downloading/unpacking blobuploader==1.2.4 15:59:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:40 INFO - Downloading blobuploader-1.2.4.tar.gz 15:59:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:59:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:59:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:59:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:59:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:40 INFO - Downloading docopt-0.6.1.tar.gz 15:59:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:59:40 INFO - Installing collected packages: blobuploader, requests, docopt 15:59:40 INFO - Running setup.py install for blobuploader 15:59:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:59:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:59:41 INFO - Running setup.py install for requests 15:59:41 INFO - Running setup.py install for docopt 15:59:41 INFO - Successfully installed blobuploader requests docopt 15:59:41 INFO - Cleaning up... 15:59:41 INFO - Return code: 0 15:59:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:59:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5b0e7e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a51410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a52310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a527a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1460501829.630477-1507377035', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:59:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:59:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:59:41 INFO - Using env: {'DISPLAY': ':0', 15:59:41 INFO - 'HOME': '/home/cltbld', 15:59:41 INFO - 'LANG': 'en_US.UTF-8', 15:59:41 INFO - 'LANGUAGE': 'en_US:en', 15:59:41 INFO - 'LOGNAME': 'cltbld', 15:59:41 INFO - 'MAIL': '/var/mail/cltbld', 15:59:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:41 INFO - 'MOZ_NO_REMOTE': '1', 15:59:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:41 INFO - 'NO_EM_RESTART': '1', 15:59:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:41 INFO - 'PWD': '/builds/slave/test', 15:59:41 INFO - 'SHELL': '/bin/bash', 15:59:41 INFO - 'SHLVL': '1', 15:59:41 INFO - 'TERM': 'linux', 15:59:41 INFO - 'TMOUT': '86400', 15:59:41 INFO - 'USER': 'cltbld', 15:59:41 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1460501829.630477-1507377035', 15:59:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:41 INFO - '_': '/tools/buildbot/bin/python'} 15:59:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:59:41 INFO - Running setup.py (path:/tmp/pip-qHeI94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:59:41 INFO - Running setup.py (path:/tmp/pip-WVQnD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:59:41 INFO - Running setup.py (path:/tmp/pip-S2uUXK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:59:41 INFO - Running setup.py (path:/tmp/pip-Z4C4Kx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:59:42 INFO - Running setup.py (path:/tmp/pip-Brl9cd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:59:42 INFO - Running setup.py (path:/tmp/pip-n9FEvu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:59:42 INFO - Running setup.py (path:/tmp/pip-YwWcu5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:59:42 INFO - Running setup.py (path:/tmp/pip-xY6yIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:59:42 INFO - Running setup.py (path:/tmp/pip-vo_Xp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:59:42 INFO - Running setup.py (path:/tmp/pip-n_YhpB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:59:42 INFO - Running setup.py (path:/tmp/pip-NQo_IB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:59:42 INFO - Running setup.py (path:/tmp/pip-KqjASE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:59:42 INFO - Running setup.py (path:/tmp/pip-jLnNFQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:59:42 INFO - Running setup.py (path:/tmp/pip-roSDeY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:59:42 INFO - Running setup.py (path:/tmp/pip-tYDkby-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:59:42 INFO - Running setup.py (path:/tmp/pip-mEqrGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:59:42 INFO - Running setup.py (path:/tmp/pip-C2s1XP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:59:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:59:43 INFO - Running setup.py install for manifestparser 15:59:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:59:43 INFO - Running setup.py install for mozcrash 15:59:43 INFO - Running setup.py install for mozdebug 15:59:43 INFO - Running setup.py install for mozdevice 15:59:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:59:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:59:43 INFO - Running setup.py install for mozfile 15:59:43 INFO - Running setup.py install for mozhttpd 15:59:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:59:43 INFO - Running setup.py install for mozinfo 15:59:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:59:43 INFO - Running setup.py install for mozInstall 15:59:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:59:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:59:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:59:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:59:43 INFO - Running setup.py install for mozleak 15:59:43 INFO - Running setup.py install for mozlog 15:59:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:59:44 INFO - Running setup.py install for moznetwork 15:59:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:59:44 INFO - Running setup.py install for mozprocess 15:59:44 INFO - Running setup.py install for mozprofile 15:59:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:59:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:59:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:59:44 INFO - Running setup.py install for mozrunner 15:59:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:59:44 INFO - Running setup.py install for mozscreenshot 15:59:44 INFO - Running setup.py install for moztest 15:59:44 INFO - Running setup.py install for mozversion 15:59:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:59:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:59:44 INFO - Cleaning up... 15:59:44 INFO - Return code: 0 15:59:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:59:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5b0e7e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a51410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a52310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a527a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1460501829.630477-1507377035', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:59:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:59:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:59:44 INFO - Using env: {'DISPLAY': ':0', 15:59:44 INFO - 'HOME': '/home/cltbld', 15:59:44 INFO - 'LANG': 'en_US.UTF-8', 15:59:44 INFO - 'LANGUAGE': 'en_US:en', 15:59:44 INFO - 'LOGNAME': 'cltbld', 15:59:44 INFO - 'MAIL': '/var/mail/cltbld', 15:59:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:44 INFO - 'MOZ_NO_REMOTE': '1', 15:59:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:44 INFO - 'NO_EM_RESTART': '1', 15:59:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:44 INFO - 'PWD': '/builds/slave/test', 15:59:44 INFO - 'SHELL': '/bin/bash', 15:59:44 INFO - 'SHLVL': '1', 15:59:44 INFO - 'TERM': 'linux', 15:59:44 INFO - 'TMOUT': '86400', 15:59:44 INFO - 'USER': 'cltbld', 15:59:44 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1460501829.630477-1507377035', 15:59:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:44 INFO - '_': '/tools/buildbot/bin/python'} 15:59:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:59:45 INFO - Running setup.py (path:/tmp/pip-zbGxbY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:59:45 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:59:45 INFO - Running setup.py (path:/tmp/pip-zATVmc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:59:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:59:45 INFO - Running setup.py (path:/tmp/pip-tlELhY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:59:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:59:45 INFO - Running setup.py (path:/tmp/pip-YTBIxs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:59:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:59:45 INFO - Running setup.py (path:/tmp/pip-D7DAGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:59:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:59:45 INFO - Running setup.py (path:/tmp/pip-yphvrH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:59:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:59:45 INFO - Running setup.py (path:/tmp/pip-WEi3NS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:59:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:59:45 INFO - Running setup.py (path:/tmp/pip-_QYVbC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:59:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:59:45 INFO - Running setup.py (path:/tmp/pip-k4KEww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:59:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:59:45 INFO - Running setup.py (path:/tmp/pip-Qjr6xu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:59:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:59:45 INFO - Running setup.py (path:/tmp/pip-CLAIgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:59:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:59:45 INFO - Running setup.py (path:/tmp/pip-z_9OXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:59:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:59:45 INFO - Running setup.py (path:/tmp/pip-UCwFCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:59:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:59:45 INFO - Running setup.py (path:/tmp/pip-I2_b97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:59:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:59:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:59:46 INFO - Running setup.py (path:/tmp/pip-jGHfFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:59:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:59:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:59:46 INFO - Running setup.py (path:/tmp/pip-m0GwgQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:59:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:59:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:59:46 INFO - Running setup.py (path:/tmp/pip-uHYS64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:59:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:59:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:59:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:59:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:59:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:59:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:59:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:59:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:48 INFO - Downloading blessings-1.6.tar.gz 15:59:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:59:48 INFO - Installing collected packages: blessings 15:59:48 INFO - Running setup.py install for blessings 15:59:48 INFO - Successfully installed blessings 15:59:48 INFO - Cleaning up... 15:59:48 INFO - Return code: 0 15:59:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:59:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:59:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:59:48 INFO - Reading from file tmpfile_stdout 15:59:48 INFO - Current package versions: 15:59:48 INFO - argparse == 1.2.1 15:59:48 INFO - blessings == 1.6 15:59:48 INFO - blobuploader == 1.2.4 15:59:48 INFO - docopt == 0.6.1 15:59:48 INFO - manifestparser == 1.1 15:59:48 INFO - mozInstall == 1.12 15:59:48 INFO - mozcrash == 0.17 15:59:48 INFO - mozdebug == 0.1 15:59:48 INFO - mozdevice == 0.48 15:59:48 INFO - mozfile == 1.2 15:59:48 INFO - mozhttpd == 0.7 15:59:48 INFO - mozinfo == 0.9 15:59:48 INFO - mozleak == 0.1 15:59:48 INFO - mozlog == 3.1 15:59:48 INFO - moznetwork == 0.27 15:59:48 INFO - mozprocess == 0.22 15:59:48 INFO - mozprofile == 0.28 15:59:48 INFO - mozrunner == 6.11 15:59:48 INFO - mozscreenshot == 0.1 15:59:48 INFO - mozsystemmonitor == 0.0 15:59:48 INFO - moztest == 0.7 15:59:48 INFO - mozversion == 1.4 15:59:48 INFO - psutil == 3.1.1 15:59:48 INFO - requests == 1.2.3 15:59:48 INFO - wsgiref == 0.1.2 15:59:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:59:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5b0e7e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a51410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a52310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a527a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1460501829.630477-1507377035', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:59:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:59:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:59:48 INFO - Using env: {'DISPLAY': ':0', 15:59:48 INFO - 'HOME': '/home/cltbld', 15:59:48 INFO - 'LANG': 'en_US.UTF-8', 15:59:48 INFO - 'LANGUAGE': 'en_US:en', 15:59:48 INFO - 'LOGNAME': 'cltbld', 15:59:48 INFO - 'MAIL': '/var/mail/cltbld', 15:59:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:48 INFO - 'MOZ_NO_REMOTE': '1', 15:59:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:48 INFO - 'NO_EM_RESTART': '1', 15:59:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:48 INFO - 'PWD': '/builds/slave/test', 15:59:48 INFO - 'SHELL': '/bin/bash', 15:59:48 INFO - 'SHLVL': '1', 15:59:48 INFO - 'TERM': 'linux', 15:59:48 INFO - 'TMOUT': '86400', 15:59:48 INFO - 'USER': 'cltbld', 15:59:48 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1460501829.630477-1507377035', 15:59:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:48 INFO - '_': '/tools/buildbot/bin/python'} 15:59:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:59:48 INFO - Cleaning up... 15:59:48 INFO - Return code: 0 15:59:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:59:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5b0e7e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a51410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a52310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a527a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1460501829.630477-1507377035', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:59:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:59:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:59:48 INFO - Using env: {'DISPLAY': ':0', 15:59:48 INFO - 'HOME': '/home/cltbld', 15:59:48 INFO - 'LANG': 'en_US.UTF-8', 15:59:48 INFO - 'LANGUAGE': 'en_US:en', 15:59:48 INFO - 'LOGNAME': 'cltbld', 15:59:48 INFO - 'MAIL': '/var/mail/cltbld', 15:59:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:48 INFO - 'MOZ_NO_REMOTE': '1', 15:59:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:48 INFO - 'NO_EM_RESTART': '1', 15:59:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:48 INFO - 'PWD': '/builds/slave/test', 15:59:48 INFO - 'SHELL': '/bin/bash', 15:59:48 INFO - 'SHLVL': '1', 15:59:48 INFO - 'TERM': 'linux', 15:59:48 INFO - 'TMOUT': '86400', 15:59:48 INFO - 'USER': 'cltbld', 15:59:48 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1460501829.630477-1507377035', 15:59:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:48 INFO - '_': '/tools/buildbot/bin/python'} 15:59:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:49 INFO - Downloading/unpacking jsonschema 15:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:59:50 INFO - Downloading/unpacking functools32 (from jsonschema) 15:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:51 INFO - Downloading functools32-3.2.3-2.tar.gz 15:59:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:59:51 INFO - warning: no files found matching '*.txt' 15:59:51 INFO - no previously-included directories found matching 'build' 15:59:51 INFO - no previously-included directories found matching 'dist' 15:59:51 INFO - no previously-included directories found matching '.git*' 15:59:51 INFO - Installing collected packages: jsonschema, functools32 15:59:51 INFO - Running setup.py install for functools32 15:59:51 INFO - warning: no files found matching '*.txt' 15:59:51 INFO - no previously-included directories found matching 'build' 15:59:51 INFO - no previously-included directories found matching 'dist' 15:59:51 INFO - no previously-included directories found matching '.git*' 15:59:51 INFO - Successfully installed jsonschema functools32 15:59:51 INFO - Cleaning up... 15:59:51 INFO - Return code: 0 15:59:51 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5b0e7e9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c25a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a51410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a52310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a527a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1460501829.630477-1507377035', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:59:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 15:59:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 15:59:51 INFO - Using env: {'DISPLAY': ':0', 15:59:51 INFO - 'HOME': '/home/cltbld', 15:59:51 INFO - 'LANG': 'en_US.UTF-8', 15:59:51 INFO - 'LANGUAGE': 'en_US:en', 15:59:51 INFO - 'LOGNAME': 'cltbld', 15:59:51 INFO - 'MAIL': '/var/mail/cltbld', 15:59:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:51 INFO - 'MOZ_NO_REMOTE': '1', 15:59:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:51 INFO - 'NO_EM_RESTART': '1', 15:59:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:51 INFO - 'PWD': '/builds/slave/test', 15:59:51 INFO - 'SHELL': '/bin/bash', 15:59:51 INFO - 'SHLVL': '1', 15:59:51 INFO - 'TERM': 'linux', 15:59:51 INFO - 'TMOUT': '86400', 15:59:51 INFO - 'USER': 'cltbld', 15:59:51 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1460501829.630477-1507377035', 15:59:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:51 INFO - '_': '/tools/buildbot/bin/python'} 15:59:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:51 INFO - Downloading/unpacking flake8 15:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:59:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:53 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:59:53 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:59:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:59:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:59:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:59:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:59:54 INFO - no previously-included directories found matching 'docs/_build' 15:59:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:59:54 INFO - Running setup.py install for pep8 15:59:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:59:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:59:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:59:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:59:54 INFO - no previously-included directories found matching 'docs/_build' 15:59:54 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:59:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:59:54 INFO - Cleaning up... 15:59:54 INFO - Return code: 0 15:59:54 INFO - Running post-action listener: _resource_record_post_action 15:59:54 INFO - Running post-action listener: _start_resource_monitoring 15:59:54 INFO - Starting resource monitoring. 15:59:54 INFO - ##### 15:59:54 INFO - ##### Running install step. 15:59:54 INFO - ##### 15:59:54 INFO - Running pre-action listener: _resource_record_pre_action 15:59:54 INFO - Running main action method: install 15:59:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:59:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:59:54 INFO - Reading from file tmpfile_stdout 15:59:54 INFO - Detecting whether we're running mozinstall >=1.0... 15:59:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:59:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:59:54 INFO - Reading from file tmpfile_stdout 15:59:54 INFO - Output received: 15:59:54 INFO - Usage: mozinstall [options] installer 15:59:54 INFO - Options: 15:59:54 INFO - -h, --help show this help message and exit 15:59:54 INFO - -d DEST, --destination=DEST 15:59:54 INFO - Directory to install application into. [default: 15:59:54 INFO - "/builds/slave/test"] 15:59:54 INFO - --app=APP Application being installed. [default: firefox] 15:59:54 INFO - mkdir: /builds/slave/test/build/application 15:59:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:59:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:00:10 INFO - Reading from file tmpfile_stdout 16:00:10 INFO - Output received: 16:00:10 INFO - /builds/slave/test/build/application/firefox/firefox 16:00:10 INFO - Running post-action listener: _resource_record_post_action 16:00:10 INFO - ##### 16:00:10 INFO - ##### Running run-tests step. 16:00:10 INFO - ##### 16:00:10 INFO - Running pre-action listener: _resource_record_pre_action 16:00:10 INFO - Running main action method: run_tests 16:00:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:00:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:00:10 INFO - Python 2.7.3 16:00:10 INFO - Return code: 0 16:00:10 INFO - grabbing minidump binary from tooltool 16:00:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:00:10 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a51410>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a52310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a527a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:00:10 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:00:10 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:00:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:00:10 INFO - Return code: 0 16:00:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:00:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:00:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:00:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:00:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:00:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:00:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:00:11 INFO - Return code: 0 16:00:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 16:00:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:00:11 INFO - Using env: {'DISPLAY': ':0', 16:00:11 INFO - 'HOME': '/home/cltbld', 16:00:11 INFO - 'LANG': 'en_US.UTF-8', 16:00:11 INFO - 'LANGUAGE': 'en_US:en', 16:00:11 INFO - 'LOGNAME': 'cltbld', 16:00:11 INFO - 'MAIL': '/var/mail/cltbld', 16:00:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:00:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:00:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:00:11 INFO - 'MOZ_NO_REMOTE': '1', 16:00:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:00:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:00:11 INFO - 'NO_EM_RESTART': '1', 16:00:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:00:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:00:11 INFO - 'PWD': '/builds/slave/test', 16:00:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:00:11 INFO - 'SHELL': '/bin/bash', 16:00:11 INFO - 'SHLVL': '1', 16:00:11 INFO - 'TERM': 'linux', 16:00:11 INFO - 'TMOUT': '86400', 16:00:11 INFO - 'USER': 'cltbld', 16:00:11 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1460501829.630477-1507377035', 16:00:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:00:11 INFO - '_': '/tools/buildbot/bin/python'} 16:00:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:00:11 INFO - mozversion application_buildid: 20160412151348 16:00:11 INFO - mozversion application_changeset: f6241b9dc0e90b1a7b418142c3a12202ebfc0df4 16:00:11 INFO - mozversion application_display_name: Nightly 16:00:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:00:11 INFO - mozversion application_name: Firefox 16:00:11 INFO - mozversion application_remotingname: firefox 16:00:11 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:00:11 INFO - mozversion application_vendor: Mozilla 16:00:11 INFO - mozversion application_version: 48.0a1 16:00:11 INFO - mozversion platform_buildid: 20160412151348 16:00:11 INFO - mozversion platform_changeset: f6241b9dc0e90b1a7b418142c3a12202ebfc0df4 16:00:11 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:00:11 INFO - mozversion platform_version: 48.0a1 16:00:11 INFO - using testdate: 1460502011 16:00:11 INFO - actual date: 1460502011 16:00:11 INFO - starting webserver on 'localhost:43303' 16:00:11 INFO - SUITE-START | Running 2 tests 16:00:11 INFO - TEST-START | dromaeo_css 16:00:11 INFO - operating with platform_type : linux_ 16:00:11 INFO - Initialising browser for dromaeo_css test... 16:00:11 INFO - TEST-INFO | started process 18871 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8MBNfb/profile http://localhost:43303/getInfo.html) 16:00:15 INFO - PROCESS | 18871 | 16:00:15 INFO - PROCESS | 18871 | (process:18939): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:00:16 INFO - PROCESS | 18871 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 16:00:16 INFO - PROCESS | 18871 | __metrics Screen width/height:1600/1200 16:00:16 INFO - PROCESS | 18871 | colorDepth:24 16:00:16 INFO - PROCESS | 18871 | Browser inner width/height: 1024/697 16:00:16 INFO - PROCESS | 18871 | __metrics 16:00:17 ERROR - PROCESS | 18871 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 16:00:18 INFO - TEST-INFO | 18871: exit 0 16:00:18 INFO - Browser initialized. 16:00:18 INFO - Running cycle 1/1 for dromaeo_css test... 16:00:18 INFO - TEST-INFO | started process 18990 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8MBNfb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:00:20 INFO - PROCESS | 18990 | 16:00:20 INFO - PROCESS | 18990 | (process:19048): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:00:30 INFO - PROCESS | 18990 | RSS: Main: 164347904 16:00:30 INFO - PROCESS | 18990 | 16:01:20 INFO - PROCESS | 18990 | 1460502080222 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 16:03:31 INFO - PROCESS | 18990 | Cycle 1(1): loaded http://localhost:43303/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43303/tests/dromaeo/cssquery-ext.html) 16:03:32 INFO - PROCESS | 18990 | RSS: Main: 169340928 16:03:32 INFO - PROCESS | 18990 | 16:06:34 INFO - PROCESS | 18990 | Cycle 1(1): loaded http://localhost:43303/tests/dromaeo/cssquery-ext.html (next: http://localhost:43303/tests/dromaeo/cssquery-jquery.html) 16:06:35 INFO - PROCESS | 18990 | RSS: Main: 165773312 16:06:35 INFO - PROCESS | 18990 | 16:09:37 INFO - PROCESS | 18990 | Cycle 1(1): loaded http://localhost:43303/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43303/tests/dromaeo/cssquery-mootools.html) 16:09:37 INFO - PROCESS | 18990 | RSS: Main: 166465536 16:09:37 INFO - PROCESS | 18990 | 16:12:39 INFO - PROCESS | 18990 | Cycle 1(1): loaded http://localhost:43303/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43303/tests/dromaeo/cssquery-prototype.html) 16:12:40 INFO - PROCESS | 18990 | RSS: Main: 164065280 16:12:40 INFO - PROCESS | 18990 | 16:15:43 INFO - PROCESS | 18990 | Cycle 1(1): loaded http://localhost:43303/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43303/tests/dromaeo/cssquery-yui.html) 16:15:43 INFO - PROCESS | 18990 | RSS: Main: 165085184 16:15:43 INFO - PROCESS | 18990 | 16:18:45 INFO - PROCESS | 18990 | Cycle 1(1): loaded http://localhost:43303/tests/dromaeo/cssquery-yui.html (next: http://localhost:43303/tests/dromaeo/cssquery-dojo.html) 16:18:46 INFO - PROCESS | 18990 | RSS: Main: 167350272 16:18:46 INFO - PROCESS | 18990 | 16:18:46 INFO - PROCESS | 18990 | __start_tp_report 16:18:46 INFO - PROCESS | 18990 | _x_x_mozilla_page_load 16:18:46 INFO - PROCESS | 18990 | _x_x_mozilla_page_load_details 16:18:46 INFO - PROCESS | 18990 | |i|pagename|runs| 16:18:46 INFO - PROCESS | 18990 | |0;dojo.html;2654.747798959099;2699.5680691089424;2739.383638681297;2757.5036493431176;2763.392053748176;4800.399950006249;4815.8796030099265;4843.85468435947;4861.73260470674;4867.902641947159;4724.220503616908;4837.274408838667;4855.980244148733;4882.8779280518;4884.804607815683;4453.576910193527;4462.1521910837;4515.254982927813;4539.364488971547;4570.634349252052;4445.755483448409;4492.842750503733;4502.122086193177;4508.752018638974;4548.385967894342;4336.869893903188;4397.274449715793;4428.6678499112695;4442.222611043055;4463.642908567339;4406.471223453174;4414.028913638995;4417.4036505072045;4448.199324121657;4463.285874260136;4396.516383197845;4405.669574781904;4431.357453169272;4440.844570440051;4474.552544745532;4699.929501057487;4724.551167639069;4736.8578942631775;4737.1946769049;4750.738709370983;5125.6155788315655;5139.691618502902;5144.56271216947;5149.742512874342;5158.587313014988;5057.5701065409485;5171.482851714798;5188.8183913563225;5200.037992971274;5222.686638801646;4810.615150787964;4864.878378040577;4866.099771542276;4884.023195360906;4910.042541704404;5307.416184219733;5309.761060752198;5331.253624492574;5339.599530035263;5387.515123638813;5017.8243761468175;5079.720615366116;5110.131277682803;5118.232265160182;5118.436971933084;5162.070827251056;5182.378114626269;5192.7403629818355;5201.3238279024245;5242.239875218072;5072.416672082684;5171.97414012935;5214.113600687892;5217.113090774577;5259.63182577216;4990.525900039491;5117.462666419972;5141.434442211354;5142.922856157161;5149.459306772735;4352.303631418958;4355.237833379146;4355.738655680606;4392.472903251631;4417.867463976086;3779.7354185207323;3788.6211378862445;3795.2788970096144;3825.846966121324;3855.190410013872;4464.598186163261;4497.392851964943;4503.234450143484;4538.092381523643;4567.634589232854;5235.764390602432;5260.421353651095;5282.788688452496;5294.152935530374;5298.311219541512;4541.591256786905;4565.657575681837;4567.611753001032;4577.359169716243;4614.400127983341;4562.703424277412;4668.673192876466;4719.221328480831;4749.572538471554;4750.904981900343;4861.052094841472;4906.656534042654;4921.3356196912955;4943.530364615356;4995.950040499549;5238.71187084714;5238.921416178684;5244.187150991603;5247.763850626655;5262.710550919736;4808.495108013748;4847.612191024639;4903.730294833818;4922.335484709519;4979.0788704089855;5142.51146141116;5179.22311653255;5182.637215394886;5185.507376799198;5222.42553319127;5074.695518268915;5228.790848366175;5238.0833354162105;5239.738013099253;5243.711595862264;4944.653874228769;5008.348914641219;5056.064628043824;5119.48805119485;5136.229565565046;5062.392512898476;5072.82245121419;5078.238264260391;5080.288759573588;5108.157154069537;4878.731669758197;4956.256561515802;4967.478414766542;4975.651704380659;4990.8752281193265;5066.265391518283;5133.358330208724;5143.948560514347;5157.329547158845;5199.168133098686;4935.16102262609;4935.901281974412;4939.036887806987;4944.851654450228;4946.505349465025 16:18:46 INFO - PROCESS | 18990 | |1;ext.html;568.9971550142249;595.2291782142127;603.9883195647295;613.1171113596422;635.3265538529159;32708;33336.83331583342;33434.66565334346;33519.49720754191;33559.16102097449;36244;36803.447948280795;36811.631883681155;36882.631173688256;36913.815430922805;7508.249175082503;7748.380129589647;7749.496282741604;7750.496217745828;7758.728444504443;7577.962110189442;7668.961655191716;7688.654010569509;7836.451448398614;7862.724804631839;7801.336886364666;7816.609169541529;7827.6868925242925;7849.8037549061155;7862.410319226053;7772.533647981111;7793.610319484032;7808.60956952153;7839.294463498312;7867.606619669051;7751.689932402697;7817.413693972975;7872.252136047066;7875.566843823587;7886.447948643598;35384.11539711502;35723.4641480378;35833.82083089568;35865.46201806975;36023.819880900686;2551.961720574193;2936.9559456608167;3063.234191452137;3101.379724055198;3118.158097313735;23837.284881453583;24017.27948161558;24387;24835.379115522075;25130.371740706447;3331.4003479373705;3415.4535274355985;3425.537552430415;3449.4653328734084;3501.4047611906035;137848;138221;138792;139215;139488.30255848757;30516.694833051828;30711.846440767655;30714.078577642707;30764;32662.673373265963;31392.372152557276;31496.055118346027;31501.212469688442;31782.364352712815;31848.522272165937;11139.33164010162;11214.215004949576;11247.66257012291;11262.436878156059;11281.774364512828;9989;9999.200063994864;10054.396736195851;10072.647457339104;10083.092521673085;7850.842983140419;8062.113167551564;8152.184781521919;8180.345572354197;8208.794780130545;3208.246062175387;3250.3174333390252;3250.8049517029053;3256.1859535116223;3270.5421241026274;913.2329733500284;933.715216858851;1003.9749006274756;1006.054308949585;1024.4672770159475;27612.447751044867;28024.43951120966;28196.859015705202;28269.43461130807;28572.285692857844;1030.253066526777;1030.5517100061497;1047.382044593678;1050.238577031646;1100.9779804404027;14641.707165856624;15032.323545440482;15046.54860354191;15198.544043678707;15348.309326080353;300895;303527;305866;306535;307038;47421;48147;48197;48248.27627585589;48275.517244827104;1199.0827017331749;1208.7479899835203;1234.370471059748;1248.2073883084306;1254.5483625894854;26637.334066647712;27772.86113569419;27805.165845024683;27846.44307113887;28244.858775706813;40956.18087638171;40976.79511602423;41583.37624935568;41620.58379416167;41646;277495;279125;280011;280264.5986770053;280428;24704.629430558198;25400;25409.87295063513;25483.61774573346;37636.435453468766;39331;39391;40121.59878401295;40539.18921621492;40704.1859162821;33910.66089339075;33930.321393572485;34027.65972340245;34186.65813341934;34422.82788586041;32747.67252327446;33032.33935321232;33305;33410.66589334173;33755.493667594514;32927.50608740919;33185.170370740925;36022.819885900404;37054.8147259262;37324;27460.436323697788;29211.415771684024;29394;29509.704902951555;29602.407951841273;23283.76716232816;23470.295891123293;23560.410989725395;23964.40088997789;23966.640500392856 16:18:46 INFO - PROCESS | 18990 | |2;jquery.html;374.2720408804874;374.9193923306489;378.4739212494632;379.7626483447845;388.0299251870324;15622.218889055559;16377.508674739747;17433.91283043583;17480.38818641348;17481.475555733316;15654.765178522332;16023;16377.83622163778;16391.688664906807;16392.180390980462;5035.748212589365;5181.481851814807;5211.192265198882;5216;5226.843194704146;3679.4848721179055;5071.239314102896;5587.413321601234;5906.970465147669;5918.526517878559;5820.563457740665;5821.912671309934;5839.7664093436215;5844.473997340238;5877.059670452729;5585.58108141889;5883.38224486427;5892.499137573312;5906;5910.34986151523;4374.8906277343;5106.131957567222;5137.691738495702;5143.3313669223135;5172.612054095958;11816.527338906433;11998.560172779235;12022.27866328023;12032.39838008105;12129.575464858775;1780.97328540072;1790.4181141129054;1875.2499000399812;1956.8043195680461;2043.1214577731569;8922.821543569156;9131.589078491485;9203.585838637277;9364.43813371193;9447.338686291961;1673.9916300418543;1692.9238184281737;1730.2732852202105;1731.994083930504;1752.3165965273554;64601.35398646;65700;67378;67812;68433;9681.70954871355;9832.60669573209;9838.311318207656;9864.704058878246;9880.40717556949;13613.931930340284;13715.314234288246;13723.45106195741;13763.141975833334;13772.65568360799;6287.339829317947;6347.460465860454;6458.2895881453005;6547.443467305332;6573.309802470767;5862.677552734555;5881.206037184926;5959.255093113361;5970.462658360769;6050.727717252734;4187.392828039917;4243.108947121139;4276.08064266178;4337.1976184405985;4375.27807911691;1655.6688662267354;1738.1483073294248;1772.3708083630383;1828.186457026637;1833.6149408624071;904.3217586809892;926.7914719188128;939.6711151097061;963.2775418436033;989.223459584223;10309.690709278733;10515;10748.462576871281;10805.297655652357;10927.562897484171;393.1959143551444;398.21154114852175;399.81408644980223;403.824336413661;407.6779344318015;5563.610547261653;5584.301962254718;5597.916031259534;5627.521660658808;5711.143328500758;400509;402533;407199;410001;414662;62489.37510624927;73670.26329736634;78918;79816;81001;437.8445651793567;453.36981595582165;455.92249317616086;458.24161013522007;460.16939424339387;9537.427754334485;9648.469334186688;10260.281780275309;10421.374717516974;10430.217733669853;32753.672463275063;32972.34055318928;33404.33191336208;34280.314393712484;34680.13299667428;46731.76634116808;47482;47734;48309.41060599237;48540.27189592088;7364.189939106587;7375;7410.925890741024;7434.702611895464;7526.32263096324;8856.937167539936;9651.324407291422;9960.701178964642;10935.726606834893;10988.560457581607;8911.73264802057;9026.007139214813;9157.542122893961;9254.537273136182;9373.718788436357;9404.764880878032;9672.903270967201;9868.161206297258;9881.851772223567;9964.352317099365;9591.520423978634;9841.26190535727;9956.800863982824;10028.799424011624;10056.54745536438;7479.36425403825;7556.962215188889;7610.353119984863;7656.234376562299;7704.499207551491;7635.503692259986;9610.95194524023;9895.25785566071;10066.848997265193;10173.135283500986 16:18:46 INFO - PROCESS | 18990 | |3;mootools.html;1439.625697318697;1472.683373074789;1599.608096016476;1762.7444020617004;1802.9729554056682;6817.863642727142;7369.926300736991;7394.44541659375;7590.924090759091;7613.695452181913;7458.366038886687;7460.104787425503;7469.178390377054;7501.774946751606;7540.585267810268;2232.6651002349613;2246.932592022242;2254.5265494246228;2265.0486795545826;2265.8980345884474;2102.6320393931;2138.818200452956;2141.6038032963875;2156.9892150539226;2164.037003533428;2201.086549082129;2211.900464479102;2223.0885337011828;2245.012194634364;2256.537409830981;2188.3544354415485;2191.3316438486254;2191.5288213034273;2191.9890400548056;2193.56128774245;2155.8275337972923;2173.9021744021557;2178.6514157734846;2182.6725991101302;2191.791779780918;7622.123455802598;7637.656305466267;7663.31030207284;7731.652075656552;7739;4386.517483076859;4541.523140070278;4546.840860569897;4568.817247310104;4597.908041839178;2935.618369611937;2950.2476868398635;3056.3734434440885;3069.570260163579;3115.2834847984864;922.4327038871113;932.2029664636706;945.5650400815633;947.7725345916999;956.9712908612684;10370.740731481697;10440.895591044069;10458.79082418355;10459.006394392596;10537.262391632588;4163.167366526707;4222.577742225752;4348.695591308578;4458.108378324348;4465.330200469891;8986.820263594691;8995.77510562228;9045.909540904639;9071.228945539571;9079.68221112258;4644.605208557243;4646.79089440976;4675.532446755297;4680.438347398334;4680.765961701902;3684.778913265159;4041.535223449282;4172.102997855475;4203.894902627398;4215.430916826251;3614.530111085542;3674.81625918703;3743.47591337213;3748.156664750409;3787.0721673189696;1237.55448038706;1253.5048655780915;1266.7213213093105;1267.0243912187564;1278.8273583066352;965.4255717847869;985.0986347491964;986.127277359542;1054.9103326217205;1240.9379531023412;7103.644817759091;7179.461540384492;7255.600941948243;7287.307705767944;7328.633568321563;421.82915919052834;459.1162013124721;459.6162204559164;461.9053094115698;466.4915242385816;5517.282753242052;5599.944000560024;5602.522278803297;5606.159076138611;5649.6327738696855;9077.137671921157;9513.33406661527;9533.52332383378;9536.90463095374;9541.809163816684;9080.591373388213;9357.485338306322;9392.718218453458;9441.300565898204;9462.810743785085;7043.8239044023285;7163.06880105583;7180.497365184387;7193.388561972186;7197.100362454693;7123.893141602776;7154.676384868816;7204.639768011683;7277.417806575355;7327.4504412168235;8331.6667333306;8505.979282486142;8514.872276915727;8539.444936079135;8635.740927772176;8483.957580212307;8613.22480976715;8768.342374321825;8796.692115776174;8903.3322500814;5991.64050156992;6620.205575330991;6817.7272909083085;6847.93152068473;6912.308769123048;7249.855002900018;7306.232845551353;7372.889406659012;7379.667914943733;7387.2243414442855;6534.771283005072;6687.966560167362;6766.255711871789;6801.965990170018;6817.2501024888215;6572.737090516517;6630.53586248958;6660.234073081658;6698.263191049078;6722.865542689216;7025.0516180317045;7042.190148133031;7061.329173728487;7123.038389817309;7125.501214914906;6503.772367967098;6552.901706474502;6567.802965911031;6568.113304703804;6585;6499.837504062436;6592.340765923369;6626.403623673892;6629.569078009914;6632.535722499379 16:18:46 INFO - PROCESS | 18990 | |4;prototype.html;302.5461807289066;305.47763324714737;310.5450514995531;312.4937601086241;317.1168296294819;5206.323177986861;5316.49493298137;5329.653572517794;5369.62412631116;5387.784488620456;5232.764525596348;5246.737663116838;5255.500727430888;5266.868328291795;5277.8416647500635;3871.59348268432;3986.7807270600106;4083.7549747015128;4107.958920410802;4130.690198235129;4069.470968774055;4077.938830917539;4091.590840915914;4092.1994322498153;4103.774292413916;4072.287349713803;4074.5314288856716;4075;4076.9184616307657;4092.427060211558;3965.9801700991597;4056.411820286057;4061.390791381287;4066.3087275163293;4078.3066878630407;3598.604153543108;3603.1532589841368;3609.079684680416;3611.855525778966;3617.385044542434;5030;5040.722760248185;5049.34358533392;5062.797488100471;5073.518015788494;4549.795259213311;4704.411948506402;4708.058388322315;4713.397444868761;4723.504032076617;5514.448555144493;5525.668459892379;5526.932552433398;5544.417836127189;5551.639143455663;3901.1027463683226;3908.9413658795143;3911.5892831252877;3916.1580260244186;3918.804059797027;5442.23808666783;5827.737751801179;5835.679037652927;5846.356900740915;5851.4148585141575;3877.418387241936;3883.1068854163136;3902.551206611219;3911.946228230202;3926.9018274543364;3949;3969.6030396960073;3973.2450834341385;3981.482407287092;3987.063040185554;4558.6581006423985;4567.429071366079;4568.908621827545;4583.083383323348;4585.426821647294;5278.762455689503;5496.422875598085;5535.972320138373;5556.194351818964;5579.553635709133;1421.3959067396315;1421.6872288096602;1434.4907557817032;1449.1884544655027;1449.3767679897535;926.8517037274004;958.3357681294933;970.1801977329145;988.9901100989042;997.1623835977668;4752.619790416758;4892.461829198785;4925.655204135676;4927.310176575283;4938.456769755324;5731.484166425042;5786.739596718157;5806.506446952057;5806.593538452352;5818.854528636818;4823.9517604824205;4870.220764677634;4914.557689807934;4932.876678083005;4936.456989731127;3072.938541229163;3084.6606873243927;3085.167004908707;3101.65881753007;3103.90688279352;5396.514313711785;5420.322459692538;5428.9185662215095;5436.238926550286;5440.863978400572;5711.8000869969355;5839.248225532323;5887.558433117448;5936.9406305937255;5947.791827286024;5355.625106242604;5388;5391.196577779533;5397.244385786072;5404.243405923174;5448.318960129984;5738.454846789548;5758.856028599319;5773.278340207474;5779.797707080232;5657.519110875622;5672.688002159921;5679.460451257124;5693.800716974886;5707.771689132388;5428.6199966002005;5450.8909821802545;5461.918071228855;5463.48096930791;5488.039593071277;3889.649931506178;3899.590542992945;3957.6635985941516;3960.900977475471;3992.4410582519054;5705.657660540381;5740.196372507936;5750.482456578928;5753.280839895013;5802.535797136304;5532.814538257447;5569.415211402745;5587.217789509391;5595.804146854841;5596.104623260258;5411.621186516906;5496.31296087989;5545.3622833374675;5556.861078473071;5589.133684278943;5454.290942177491;5462.3445186577865;5482.671039737628;5488.121900495901;5502.339719233558;5269.604779641466;5416.8104116355735;5603.915941260802;5607.579431542732;5610.326760788732;5457.0995785696505;5457.645253058538;5468.234447177478;5469.398366179637;5469.453054694499 16:18:46 INFO - PROCESS | 18990 | |5;yui.html;681.4207923265224;681.7955608639396;776.4758787818221;778.7858338956786;783.1502819440906;12351.073669474792;12510;12527;12682.682932926682;12685.238885666866;12595.559155429562;13177.538786142486;13213.471461141542;13274.20354778714;13278.070535062525;651.8174911024921;811.6185392865344;812.3866480807012;818.1368656067846;819.4018366592361;792.9246721561442;817.9836403271931;818.3248819723722;818.3657665309373;819.2994989284166;857.1043259793499;857.1985193843776;865.0441262405046;868.2619773192798;870.0299166429448;855.7561095087901;858.5964596639539;860.1527495417009;863.046333801147;863.9222469977669;631.826247781859;636.141209367355;637.9489640828723;638.1894993358455;638.7157714816908;12861.228326300452;12913.289769062698;12913.741725165444;12930.224186548838;12934.159279646887;12603.621891343275;12604.558840440632;12633.684157896034;12651.683707907285;12811.743765124738;9679.903200968041;9791.902080979242;9889.406635601816;10151.340162889388;10319;3335.232896433834;3361.781484203519;3374.797512149279;3435.2442462658173;3456.6370531094126;46979.29531057037;47336.76331618354;47902.52097479015;48028.75985620049;48392.75803620995;9877.703668889944;10037.447940363205;10048.949755251324;10145.847812282822;10147.441890696082;16758.32966681319;16878;16901.91549042247;16904;16910.32358705638;6811.012403201607;6974.4420446364165;7007;7016.894746578805;7167.534110282815;3804.505414296124;3816.866409675648;3817.5991520889906;3867.323218436762;3913.4325522799036;2952.143878275319;3036.6659667436566;3042.3154790172475;3046.8628911699025;3053.603031605877;521.6087934049463;532.0502902319341;533.6797921247298;537.760696490066;543.2204786131913;497.57954528423426;530.4218401941902;542.9131338985743;598.9281286245591;613.3804857094367;7776;8104.27061564462;8246.628901699438;8332.33341332692;8520.74437766868;481.8000529780172;560.7112337146373;576.7548791763484;589.0104624231247;651.495091304243;3682.9447558286647;3804.505414296124;3861.7876016819346;3871.7289789715014;3946.546147193052;47699;47804.5219547807;47813;48161.5183848164;49155.01689966252;43654;44066.55933440624;44289;44506;44660.55339446629;41272;41282.1743565127;41590.584094159276;42121.36817947733;42121.578784212994;7619.733309334147;7664.6550905210515;7705.730299439717;7752.612369381395;7862.960685196537;28303.858480707466;28336.291592710346;28491.28771780722;28755.13734587966;28893;34453.82773086119;35012.64987350094;35143.47284790679;35252.647473524936;35994.28011439809;10798.568057277935;10835.404052777172;10840.186985976241;10922.634670666166;11165.609203677832;12044.061464057446;12183.939080304543;12294.81557776652;12318.938405307916;12319.322437266037;10795.082417994558;10811.6215932442;10952.233343665866;11699.532018719156;11865.644030679094;11314.191468625966;11420.600278990196;11566.19036667459;11606.94196529012;11672.824907626222;10573.154147668321;10625.415602141647;10760.569577216824;10798.138354555507;11080.168987325822;8982.775430614287;9093.181613654802;9105.453672779655;9401.153896149379;9603.711888643353;9661.864537242564;9714.174295184988;9793.265505087005;9805.607775689177;9936.950315248667 16:18:46 INFO - PROCESS | 18990 | __end_tp_report 16:18:46 INFO - PROCESS | 18990 | __start_cc_report 16:18:46 INFO - PROCESS | 18990 | _x_x_mozilla_cycle_collect,392 16:18:46 INFO - PROCESS | 18990 | __end_cc_report 16:18:46 INFO - PROCESS | 18990 | __startTimestamp1460503126072__endTimestamp 16:18:46 INFO - PROCESS | 18990 | 16:18:46 INFO - PROCESS | 18990 | ------- Summary: start ------- 16:18:46 INFO - PROCESS | 18990 | Number of tests: 6 16:18:46 INFO - PROCESS | 18990 | 16:18:46 INFO - PROCESS | 18990 | [#0] dojo.html Cycles:165 Average:4798.74 Median:4922.34 stddev:505.29 (10.3%) stddev-sans-first:478.03 16:18:46 INFO - PROCESS | 18990 | Values: 2654.7 2699.6 2739.4 2757.5 2763.4 4800.4 4815.9 4843.9 4861.7 4867.9 4724.2 4837.3 4856.0 4882.9 4884.8 4453.6 4462.2 4515.3 4539.4 4570.6 4445.8 4492.8 4502.1 4508.8 4548.4 4336.9 4397.3 4428.7 4442.2 4463.6 4406.5 4414.0 4417.4 4448.2 4463.3 4396.5 4405.7 4431.4 4440.8 4474.6 4699.9 4724.6 4736.9 4737.2 4750.7 5125.6 5139.7 5144.6 5149.7 5158.6 5057.6 5171.5 5188.8 5200.0 5222.7 4810.6 4864.9 4866.1 4884.0 4910.0 5307.4 5309.8 5331.3 5339.6 5387.5 5017.8 5079.7 5110.1 5118.2 5118.4 5162.1 5182.4 5192.7 5201.3 5242.2 5072.4 5172.0 5214.1 5217.1 5259.6 4990.5 5117.5 5141.4 5142.9 5149.5 4352.3 4355.2 4355.7 4392.5 4417.9 3779.7 3788.6 3795.3 3825.8 3855.2 4464.6 4497.4 4503.2 4538.1 4567.6 5235.8 5260.4 5282.8 5294.2 5298.3 4541.6 4565.7 4567.6 4577.4 4614.4 4562.7 4668.7 4719.2 4749.6 4750.9 4861.1 4906.7 4921.3 4943.5 4996.0 5238.7 5238.9 5244.2 5247.8 5262.7 4808.5 4847.6 4903.7 4922.3 4979.1 5142.5 5179.2 5182.6 5185.5 5222.4 5074.7 5228.8 5238.1 5239.7 5243.7 4944.7 5008.3 5056.1 5119.5 5136.2 5062.4 5072.8 5078.2 5080.3 5108.2 4878.7 4956.3 4967.5 4975.7 4990.9 5066.3 5133.4 5143.9 5157.3 5199.2 4935.2 4935.9 4939.0 4944.9 4946.5 16:18:46 INFO - PROCESS | 18990 | 16:18:46 INFO - PROCESS | 18990 | [#1] ext.html Cycles:180 Average:38360.69 Median:32727.84 stddev:66288.38 (202.5%) stddev-sans-first:66413.61 16:18:46 INFO - PROCESS | 18990 | Values: 569.0 595.2 604.0 613.1 635.3 32708.0 33336.8 33434.7 33519.5 33559.2 36244.0 36803.4 36811.6 36882.6 36913.8 7508.2 7748.4 7749.5 7750.5 7758.7 7578.0 7669.0 7688.7 7836.5 7862.7 7801.3 7816.6 7827.7 7849.8 7862.4 7772.5 7793.6 7808.6 7839.3 7867.6 7751.7 7817.4 7872.3 7875.6 7886.4 35384.1 35723.5 35833.8 35865.5 36023.8 2552.0 2937.0 3063.2 3101.4 3118.2 23837.3 24017.3 24387.0 24835.4 25130.4 3331.4 3415.5 3425.5 3449.5 3501.4 137848.0 138221.0 138792.0 139215.0 139488.3 30516.7 30711.8 30714.1 30764.0 32662.7 31392.4 31496.1 31501.2 31782.4 31848.5 11139.3 11214.2 11247.7 11262.4 11281.8 9989.0 9999.2 10054.4 10072.6 10083.1 7850.8 8062.1 8152.2 8180.3 8208.8 3208.2 3250.3 3250.8 3256.2 3270.5 913.2 933.7 1004.0 1006.1 1024.5 27612.4 28024.4 28196.9 28269.4 28572.3 1030.3 1030.6 1047.4 1050.2 1101.0 14641.7 15032.3 15046.5 15198.5 15348.3 300895.0 303527.0 305866.0 306535.0 307038.0 47421.0 48147.0 48197.0 48248.3 48275.5 1199.1 1208.7 1234.4 1248.2 1254.5 26637.3 27772.9 27805.2 27846.4 28244.9 40956.2 40976.8 41583.4 41620.6 41646.0 277495.0 279125.0 280011.0 280264.6 280428.0 24704.6 25400.0 25409.9 25483.6 37636.4 39331.0 39391.0 40121.6 40539.2 40704.2 33910.7 33930.3 34027.7 34186.7 34422.8 32747.7 33032.3 33305.0 33410.7 33755.5 32927.5 33185.2 36022.8 37054.8 37324.0 27460.4 29211.4 29394.0 29509.7 29602.4 23283.8 23470.3 23560.4 23964.4 23966.6 16:18:46 INFO - PROCESS | 18990 | 16:18:46 INFO - PROCESS | 18990 | [#2] jquery.html Cycles:180 Average:23586.81 Median:5157.97 stddev:67133.65 (1301.6%) stddev-sans-first:67299.35 16:18:46 INFO - PROCESS | 18990 | Values: 374.3 374.9 378.5 379.8 388.0 15622.2 16377.5 17433.9 17480.4 17481.5 15654.8 16023.0 16377.8 16391.7 16392.2 5035.7 5181.5 5211.2 5216.0 5226.8 3679.5 5071.2 5587.4 5907.0 5918.5 5820.6 5821.9 5839.8 5844.5 5877.1 5585.6 5883.4 5892.5 5906.0 5910.3 4374.9 5106.1 5137.7 5143.3 5172.6 11816.5 11998.6 12022.3 12032.4 12129.6 1781.0 1790.4 1875.2 1956.8 2043.1 8922.8 9131.6 9203.6 9364.4 9447.3 1674.0 1692.9 1730.3 1732.0 1752.3 64601.4 65700.0 67378.0 67812.0 68433.0 9681.7 9832.6 9838.3 9864.7 9880.4 13613.9 13715.3 13723.5 13763.1 13772.7 6287.3 6347.5 6458.3 6547.4 6573.3 5862.7 5881.2 5959.3 5970.5 6050.7 4187.4 4243.1 4276.1 4337.2 4375.3 1655.7 1738.1 1772.4 1828.2 1833.6 904.3 926.8 939.7 963.3 989.2 10309.7 10515.0 10748.5 10805.3 10927.6 393.2 398.2 399.8 403.8 407.7 5563.6 5584.3 5597.9 5627.5 5711.1 400509.0 402533.0 407199.0 410001.0 414662.0 62489.4 73670.3 78918.0 79816.0 81001.0 437.8 453.4 455.9 458.2 460.2 9537.4 9648.5 10260.3 10421.4 10430.2 32753.7 32972.3 33404.3 34280.3 34680.1 46731.8 47482.0 47734.0 48309.4 48540.3 7364.2 7375.0 7410.9 7434.7 7526.3 8856.9 9651.3 9960.7 10935.7 10988.6 8911.7 9026.0 9157.5 9254.5 9373.7 9404.8 9672.9 9868.2 9881.9 9964.4 9591.5 9841.3 9956.8 10028.8 10056.5 7479.4 7557.0 7610.4 7656.2 7704.5 7635.5 9611.0 9895.3 10066.8 10173.1 16:18:46 INFO - PROCESS | 18990 | 16:18:46 INFO - PROCESS | 18990 | [#3] mootools.html Cycles:180 Average:5373.18 Median:6588.67 stddev:2835.19 (43.0%) stddev-sans-first:2827.73 16:18:46 INFO - PROCESS | 18990 | Values: 1439.6 1472.7 1599.6 1762.7 1803.0 6817.9 7369.9 7394.4 7590.9 7613.7 7458.4 7460.1 7469.2 7501.8 7540.6 2232.7 2246.9 2254.5 2265.0 2265.9 2102.6 2138.8 2141.6 2157.0 2164.0 2201.1 2211.9 2223.1 2245.0 2256.5 2188.4 2191.3 2191.5 2192.0 2193.6 2155.8 2173.9 2178.7 2182.7 2191.8 7622.1 7637.7 7663.3 7731.7 7739.0 4386.5 4541.5 4546.8 4568.8 4597.9 2935.6 2950.2 3056.4 3069.6 3115.3 922.4 932.2 945.6 947.8 957.0 10370.7 10440.9 10458.8 10459.0 10537.3 4163.2 4222.6 4348.7 4458.1 4465.3 8986.8 8995.8 9045.9 9071.2 9079.7 4644.6 4646.8 4675.5 4680.4 4680.8 3684.8 4041.5 4172.1 4203.9 4215.4 3614.5 3674.8 3743.5 3748.2 3787.1 1237.6 1253.5 1266.7 1267.0 1278.8 965.4 985.1 986.1 1054.9 1240.9 7103.6 7179.5 7255.6 7287.3 7328.6 421.8 459.1 459.6 461.9 466.5 5517.3 5599.9 5602.5 5606.2 5649.6 9077.1 9513.3 9533.5 9536.9 9541.8 9080.6 9357.5 9392.7 9441.3 9462.8 7043.8 7163.1 7180.5 7193.4 7197.1 7123.9 7154.7 7204.6 7277.4 7327.5 8331.7 8506.0 8514.9 8539.4 8635.7 8484.0 8613.2 8768.3 8796.7 8903.3 5991.6 6620.2 6817.7 6847.9 6912.3 7249.9 7306.2 7372.9 7379.7 7387.2 6534.8 6688.0 6766.3 6802.0 6817.3 6572.7 6630.5 6660.2 6698.3 6722.9 7025.1 7042.2 7061.3 7123.0 7125.5 6503.8 6552.9 6567.8 6568.1 6585.0 6499.8 6592.3 6626.4 6629.6 6632.5 16:18:46 INFO - PROCESS | 18990 | 16:18:46 INFO - PROCESS | 18990 | [#4] prototype.html Cycles:180 Average:4595.19 Median:5273.72 stddev:1349.27 (25.6%) stddev-sans-first:1314.02 16:18:46 INFO - PROCESS | 18990 | Values: 302.5 305.5 310.5 312.5 317.1 5206.3 5316.5 5329.7 5369.6 5387.8 5232.8 5246.7 5255.5 5266.9 5277.8 3871.6 3986.8 4083.8 4108.0 4130.7 4069.5 4077.9 4091.6 4092.2 4103.8 4072.3 4074.5 4075.0 4076.9 4092.4 3966.0 4056.4 4061.4 4066.3 4078.3 3598.6 3603.2 3609.1 3611.9 3617.4 5030.0 5040.7 5049.3 5062.8 5073.5 4549.8 4704.4 4708.1 4713.4 4723.5 5514.4 5525.7 5526.9 5544.4 5551.6 3901.1 3908.9 3911.6 3916.2 3918.8 5442.2 5827.7 5835.7 5846.4 5851.4 3877.4 3883.1 3902.6 3911.9 3926.9 3949.0 3969.6 3973.2 3981.5 3987.1 4558.7 4567.4 4568.9 4583.1 4585.4 5278.8 5496.4 5536.0 5556.2 5579.6 1421.4 1421.7 1434.5 1449.2 1449.4 926.9 958.3 970.2 989.0 997.2 4752.6 4892.5 4925.7 4927.3 4938.5 5731.5 5786.7 5806.5 5806.6 5818.9 4824.0 4870.2 4914.6 4932.9 4936.5 3072.9 3084.7 3085.2 3101.7 3103.9 5396.5 5420.3 5428.9 5436.2 5440.9 5711.8 5839.2 5887.6 5936.9 5947.8 5355.6 5388.0 5391.2 5397.2 5404.2 5448.3 5738.5 5758.9 5773.3 5779.8 5657.5 5672.7 5679.5 5693.8 5707.8 5428.6 5450.9 5461.9 5463.5 5488.0 3889.6 3899.6 3957.7 3960.9 3992.4 5705.7 5740.2 5750.5 5753.3 5802.5 5532.8 5569.4 5587.2 5595.8 5596.1 5411.6 5496.3 5545.4 5556.9 5589.1 5454.3 5462.3 5482.7 5488.1 5502.3 5269.6 5416.8 5603.9 5607.6 5610.3 5457.1 5457.6 5468.2 5469.4 5469.5 16:18:46 INFO - PROCESS | 18990 | 16:18:46 INFO - PROCESS | 18990 | [#5] yui.html Cycles:180 Average:12573.73 Median:42887.79 stddev:13829.21 (32.2%) stddev-sans-first:13839.16 16:18:46 INFO - PROCESS | 18990 | Values: 681.4 681.8 776.5 778.8 783.2 12351.1 12510.0 12527.0 12682.7 12685.2 12595.6 13177.5 13213.5 13274.2 13278.1 651.8 811.6 812.4 818.1 819.4 792.9 818.0 818.3 818.4 819.3 857.1 857.2 865.0 868.3 870.0 855.8 858.6 860.2 863.0 863.9 631.8 636.1 637.9 638.2 638.7 12861.2 12913.3 12913.7 12930.2 12934.2 12603.6 12604.6 12633.7 12651.7 12811.7 9679.9 9791.9 9889.4 10151.3 10319.0 3335.2 3361.8 3374.8 3435.2 3456.6 46979.3 47336.8 47902.5 48028.8 48392.8 9877.7 10037.4 10048.9 10145.8 10147.4 16758.3 16878.0 16901.9 16904.0 16910.3 6811.0 6974.4 7007.0 7016.9 7167.5 3804.5 3816.9 3817.6 3867.3 3913.4 2952.1 3036.7 3042.3 3046.9 3053.6 521.6 532.1 533.7 537.8 543.2 497.6 530.4 542.9 598.9 613.4 7776.0 8104.3 8246.6 8332.3 8520.7 481.8 560.7 576.8 589.0 651.5 3682.9 3804.5 3861.8 3871.7 3946.5 47699.0 47804.5 47813.0 48161.5 49155.0 43654.0 44066.6 44289.0 44506.0 44660.6 41272.0 41282.2 41590.6 42121.4 42121.6 7619.7 7664.7 7705.7 7752.6 7863.0 28303.9 28336.3 28491.3 28755.1 28893.0 34453.8 35012.6 35143.5 35252.6 35994.3 10798.6 10835.4 10840.2 10922.6 11165.6 12044.1 12183.9 12294.8 12318.9 12319.3 10795.1 10811.6 10952.2 11699.5 11865.6 11314.2 11420.6 11566.2 11606.9 11672.8 10573.2 10625.4 10760.6 10798.1 11080.2 8982.8 9093.2 9105.5 9401.2 9603.7 9661.9 9714.2 9793.3 9805.6 9937.0 16:18:46 INFO - PROCESS | 18990 | -------- Summary: end -------- 16:18:46 INFO - PROCESS | 18990 | 16:18:46 INFO - TEST-INFO | 18990: exit 0 16:18:46 INFO - TEST-OK | dromaeo_css | took 1115242ms 16:18:46 INFO - TEST-START | kraken 16:18:46 INFO - operating with platform_type : linux_ 16:18:46 INFO - Initialising browser for kraken test... 16:18:46 INFO - TEST-INFO | started process 19228 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZYdCGy/profile http://localhost:43303/getInfo.html) 16:18:50 INFO - PROCESS | 19228 | 16:18:50 INFO - PROCESS | 19228 | (process:19296): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:18:51 INFO - PROCESS | 19228 | JavaScript error: jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 16:18:51 INFO - PROCESS | 19228 | __metrics Screen width/height:1600/1200 16:18:51 INFO - PROCESS | 19228 | colorDepth:24 16:18:51 INFO - PROCESS | 19228 | Browser inner width/height: 1024/697 16:18:51 INFO - PROCESS | 19228 | __metrics 16:18:52 ERROR - PROCESS | 19228 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 16:18:53 INFO - TEST-INFO | 19228: exit 0 16:18:53 INFO - Browser initialized. 16:18:53 INFO - Running cycle 1/1 for kraken test... 16:18:53 INFO - TEST-INFO | started process 19348 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZYdCGy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:18:55 INFO - PROCESS | 19348 | 16:18:55 INFO - PROCESS | 19348 | (process:19406): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:19:05 INFO - PROCESS | 19348 | RSS: Main: 164220928 16:19:05 INFO - PROCESS | 19348 | 16:19:08 INFO - PROCESS | 19348 | Cycle 1(1): loaded http://localhost:43303/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43303/tests/kraken/driver.html?testName=audio-beat-detection) 16:19:09 INFO - PROCESS | 19348 | RSS: Main: 167383040 16:19:09 INFO - PROCESS | 19348 | 16:19:12 INFO - PROCESS | 19348 | Cycle 1(1): loaded http://localhost:43303/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43303/tests/kraken/driver.html?testName=audio-dft) 16:19:12 INFO - PROCESS | 19348 | RSS: Main: 170536960 16:19:12 INFO - PROCESS | 19348 | 16:19:15 INFO - PROCESS | 19348 | Cycle 1(1): loaded http://localhost:43303/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43303/tests/kraken/driver.html?testName=audio-fft) 16:19:16 INFO - PROCESS | 19348 | RSS: Main: 162050048 16:19:16 INFO - PROCESS | 19348 | 16:19:18 INFO - PROCESS | 19348 | Cycle 1(1): loaded http://localhost:43303/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43303/tests/kraken/driver.html?testName=audio-oscillator) 16:19:18 INFO - PROCESS | 19348 | RSS: Main: 162664448 16:19:18 INFO - PROCESS | 19348 | 16:19:21 INFO - PROCESS | 19348 | Cycle 1(1): loaded http://localhost:43303/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43303/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:19:21 INFO - PROCESS | 19348 | RSS: Main: 164913152 16:19:21 INFO - PROCESS | 19348 | 16:19:25 INFO - PROCESS | 19348 | Cycle 1(1): loaded http://localhost:43303/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43303/tests/kraken/driver.html?testName=imaging-darkroom) 16:19:25 INFO - PROCESS | 19348 | RSS: Main: 164429824 16:19:25 INFO - PROCESS | 19348 | 16:19:29 INFO - PROCESS | 19348 | Cycle 1(1): loaded http://localhost:43303/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43303/tests/kraken/driver.html?testName=imaging-desaturate) 16:19:29 INFO - PROCESS | 19348 | RSS: Main: 163958784 16:19:29 INFO - PROCESS | 19348 | 16:19:32 INFO - PROCESS | 19348 | Cycle 1(1): loaded http://localhost:43303/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43303/tests/kraken/driver.html?testName=json-parse-financial) 16:19:33 INFO - PROCESS | 19348 | RSS: Main: 164577280 16:19:33 INFO - PROCESS | 19348 | 16:19:35 INFO - PROCESS | 19348 | Cycle 1(1): loaded http://localhost:43303/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43303/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:19:35 INFO - PROCESS | 19348 | RSS: Main: 164622336 16:19:35 INFO - PROCESS | 19348 | 16:19:37 INFO - PROCESS | 19348 | Cycle 1(1): loaded http://localhost:43303/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43303/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:19:38 INFO - PROCESS | 19348 | RSS: Main: 164585472 16:19:38 INFO - PROCESS | 19348 | 16:19:40 INFO - PROCESS | 19348 | Cycle 1(1): loaded http://localhost:43303/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43303/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:19:41 INFO - PROCESS | 19348 | RSS: Main: 165171200 16:19:41 INFO - PROCESS | 19348 | 16:19:44 INFO - PROCESS | 19348 | Cycle 1(1): loaded http://localhost:43303/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43303/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:19:44 INFO - PROCESS | 19348 | RSS: Main: 165421056 16:19:44 INFO - PROCESS | 19348 | 16:19:47 INFO - PROCESS | 19348 | Cycle 1(1): loaded http://localhost:43303/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43303/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:19:48 INFO - PROCESS | 19348 | RSS: Main: 165609472 16:19:48 INFO - PROCESS | 19348 | 16:19:50 INFO - PROCESS | 19348 | Cycle 1(1): loaded http://localhost:43303/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43303/tests/kraken/driver.html?testName=ai-astar) 16:19:50 INFO - PROCESS | 19348 | RSS: Main: 167157760 16:19:50 INFO - PROCESS | 19348 | 16:19:50 INFO - PROCESS | 19348 | __start_tp_report 16:19:50 INFO - PROCESS | 19348 | _x_x_mozilla_page_load 16:19:50 INFO - PROCESS | 19348 | _x_x_mozilla_page_load_details 16:19:50 INFO - PROCESS | 19348 | |i|pagename|runs| 16:19:50 INFO - PROCESS | 19348 | |0;ai-astar;114;114;115;113;115;133;114;113;114;115 16:19:50 INFO - PROCESS | 19348 | |1;audio-beat-detection;159;135;154;195;134;164;158;133;190;134 16:19:50 INFO - PROCESS | 19348 | |2;audio-dft;166;162;165;166;167;166;165;162;165;162 16:19:50 INFO - PROCESS | 19348 | |3;audio-fft;74;77;72;153;76;78;77;73;151;76 16:19:50 INFO - PROCESS | 19348 | |4;audio-oscillator;95;95;156;95;94;94;133;95;95;146 16:19:50 INFO - PROCESS | 19348 | |5;imaging-gaussian-blur;117;117;117;117;117;124;118;118;117;118 16:19:50 INFO - PROCESS | 19348 | |6;imaging-darkroom;147;148;147;147;147;147;148;147;148;146 16:19:50 INFO - PROCESS | 19348 | |7;imaging-desaturate;96;96;98;96;96;96;96;96;97;97 16:19:50 INFO - PROCESS | 19348 | |8;json-parse-financial;64;63;64;66;64;64;65;83;63;63 16:19:50 INFO - PROCESS | 19348 | |9;json-stringify-tinderbox;65;65;64;65;65;63;63;64;65;64 16:19:50 INFO - PROCESS | 19348 | |10;stanford-crypto-aes;86;85;90;90;88;94;93;87;86;86 16:19:50 INFO - PROCESS | 19348 | |11;stanford-crypto-ccm;150;154;144;151;140;143;140;141;175;151 16:19:50 INFO - PROCESS | 19348 | |12;stanford-crypto-pbkdf2;177;177;173;181;175;175;170;172;174;176 16:19:50 INFO - PROCESS | 19348 | |13;stanford-crypto-sha256-iterative;71;71;72;72;73;73;72;71;72;74 16:19:50 INFO - PROCESS | 19348 | __end_tp_report 16:19:50 INFO - PROCESS | 19348 | __start_cc_report 16:19:50 INFO - PROCESS | 19348 | _x_x_mozilla_cycle_collect,952 16:19:50 INFO - PROCESS | 19348 | __end_cc_report 16:19:50 INFO - PROCESS | 19348 | __startTimestamp1460503190295__endTimestamp 16:19:50 INFO - PROCESS | 19348 | 16:19:50 INFO - PROCESS | 19348 | ------- Summary: start ------- 16:19:50 INFO - PROCESS | 19348 | Number of tests: 14 16:19:50 INFO - PROCESS | 19348 | 16:19:50 INFO - PROCESS | 19348 | [#0] ai-astar Cycles:10 Average:116.00 Median:114.50 stddev:6.02 (5.3%) stddev-sans-first:6.34 16:19:50 INFO - PROCESS | 19348 | Values: 114.0 114.0 115.0 113.0 115.0 133.0 114.0 113.0 114.0 115.0 16:19:50 INFO - PROCESS | 19348 | 16:19:50 INFO - PROCESS | 19348 | [#1] audio-beat-detection Cycles:10 Average:155.60 Median:158.50 stddev:22.84 (14.4%) stddev-sans-first:24.19 16:19:50 INFO - PROCESS | 19348 | Values: 159.0 135.0 154.0 195.0 134.0 164.0 158.0 133.0 190.0 134.0 16:19:50 INFO - PROCESS | 19348 | 16:19:50 INFO - PROCESS | 19348 | [#2] audio-dft Cycles:10 Average:164.60 Median:165.50 stddev:1.90 (1.1%) stddev-sans-first:1.94 16:19:50 INFO - PROCESS | 19348 | Values: 166.0 162.0 165.0 166.0 167.0 166.0 165.0 162.0 165.0 162.0 16:19:50 INFO - PROCESS | 19348 | 16:19:50 INFO - PROCESS | 19348 | [#3] audio-fft Cycles:10 Average:90.70 Median:76.00 stddev:32.37 (42.6%) stddev-sans-first:33.76 16:19:50 INFO - PROCESS | 19348 | Values: 74.0 77.0 72.0 153.0 76.0 78.0 77.0 73.0 151.0 76.0 16:19:50 INFO - PROCESS | 19348 | 16:19:50 INFO - PROCESS | 19348 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:95.00 stddev:24.89 (26.2%) stddev-sans-first:25.82 16:19:50 INFO - PROCESS | 19348 | Values: 95.0 95.0 156.0 95.0 94.0 94.0 133.0 95.0 95.0 146.0 16:19:50 INFO - PROCESS | 19348 | 16:19:50 INFO - PROCESS | 19348 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:117.50 stddev:2.16 (1.8%) stddev-sans-first:2.26 16:19:50 INFO - PROCESS | 19348 | Values: 117.0 117.0 117.0 117.0 117.0 124.0 118.0 118.0 117.0 118.0 16:19:50 INFO - PROCESS | 19348 | 16:19:50 INFO - PROCESS | 19348 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 16:19:50 INFO - PROCESS | 19348 | Values: 147.0 148.0 147.0 147.0 147.0 147.0 148.0 147.0 148.0 146.0 16:19:50 INFO - PROCESS | 19348 | 16:19:50 INFO - PROCESS | 19348 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 16:19:50 INFO - PROCESS | 19348 | Values: 96.0 96.0 98.0 96.0 96.0 96.0 96.0 96.0 97.0 97.0 16:19:50 INFO - PROCESS | 19348 | 16:19:50 INFO - PROCESS | 19348 | [#8] json-parse-financial Cycles:10 Average:65.90 Median:64.00 stddev:6.08 (9.5%) stddev-sans-first:6.41 16:19:50 INFO - PROCESS | 19348 | Values: 64.0 63.0 64.0 66.0 64.0 64.0 65.0 83.0 63.0 63.0 16:19:50 INFO - PROCESS | 19348 | 16:19:50 INFO - PROCESS | 19348 | [#9] json-stringify-tinderbox Cycles:10 Average:64.30 Median:65.00 stddev:0.82 (1.3%) stddev-sans-first:0.83 16:19:50 INFO - PROCESS | 19348 | Values: 65.0 65.0 64.0 65.0 65.0 63.0 63.0 64.0 65.0 64.0 16:19:50 INFO - PROCESS | 19348 | 16:19:50 INFO - PROCESS | 19348 | [#10] stanford-crypto-aes Cycles:10 Average:88.50 Median:89.00 stddev:3.14 (3.5%) stddev-sans-first:3.19 16:19:50 INFO - PROCESS | 19348 | Values: 86.0 85.0 90.0 90.0 88.0 94.0 93.0 87.0 86.0 86.0 16:19:50 INFO - PROCESS | 19348 | 16:19:50 INFO - PROCESS | 19348 | [#11] stanford-crypto-ccm Cycles:10 Average:148.90 Median:150.50 stddev:10.52 (7.0%) stddev-sans-first:11.16 16:19:50 INFO - PROCESS | 19348 | Values: 150.0 154.0 144.0 151.0 140.0 143.0 140.0 141.0 175.0 151.0 16:19:50 INFO - PROCESS | 19348 | 16:19:50 INFO - PROCESS | 19348 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.00 Median:175.50 stddev:3.06 (1.7%) stddev-sans-first:3.15 16:19:50 INFO - PROCESS | 19348 | Values: 177.0 177.0 173.0 181.0 175.0 175.0 170.0 172.0 174.0 176.0 16:19:50 INFO - PROCESS | 19348 | 16:19:50 INFO - PROCESS | 19348 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.10 Median:72.00 stddev:0.99 (1.4%) stddev-sans-first:0.97 16:19:50 INFO - PROCESS | 19348 | Values: 71.0 71.0 72.0 72.0 73.0 73.0 72.0 71.0 72.0 74.0 16:19:50 INFO - PROCESS | 19348 | -------- Summary: end -------- 16:19:50 INFO - PROCESS | 19348 | 16:19:51 INFO - TEST-INFO | 19348: exit 0 16:19:51 INFO - TEST-OK | kraken | took 64537ms 16:19:51 INFO - SUITE-END | took 1179s 16:19:51 INFO - Completed test suite (00:19:39) 16:19:51 INFO - javascript benchmark 16:19:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2654.747798959099, 2699.5680691089424, 2739.383638681297, 2757.5036493431176, 2763.392053748176, 4800.399950006249, 4815.8796030099265, 4843.85468435947, 4861.73260470674, 4867.902641947159, 4724.220503616908, 4837.274408838667, 4855.980244148733, 4882.8779280518, 4884.804607815683, 4453.576910193527, 4462.1521910837, 4515.254982927813, 4539.364488971547, 4570.634349252052, 4445.755483448409, 4492.842750503733, 4502.122086193177, 4508.752018638974, 4548.385967894342, 4336.869893903188, 4397.274449715793, 4428.6678499112695, 4442.222611043055, 4463.642908567339, 4406.471223453174, 4414.028913638995, 4417.4036505072045, 4448.199324121657, 4463.285874260136, 4396.516383197845, 4405.669574781904, 4431.357453169272, 4440.844570440051, 4474.552544745532, 4699.929501057487, 4724.551167639069, 4736.8578942631775, 4737.1946769049, 4750.738709370983, 5125.6155788315655, 5139.691618502902, 5144.56271216947, 5149.742512874342, 5158.587313014988, 5057.5701065409485, 5171.482851714798, 5188.8183913563225, 5200.037992971274, 5222.686638801646, 4810.615150787964, 4864.878378040577, 4866.099771542276, 4884.023195360906, 4910.042541704404, 5307.416184219733, 5309.761060752198, 5331.253624492574, 5339.599530035263, 5387.515123638813, 5017.8243761468175, 5079.720615366116, 5110.131277682803, 5118.232265160182, 5118.436971933084, 5162.070827251056, 5182.378114626269, 5192.7403629818355, 5201.3238279024245, 5242.239875218072, 5072.416672082684, 5171.97414012935, 5214.113600687892, 5217.113090774577, 5259.63182577216, 4990.525900039491, 5117.462666419972, 5141.434442211354, 5142.922856157161, 5149.459306772735, 4352.303631418958, 4355.237833379146, 4355.738655680606, 4392.472903251631, 4417.867463976086, 3779.7354185207323, 3788.6211378862445, 3795.2788970096144, 3825.846966121324, 3855.190410013872, 4464.598186163261, 4497.392851964943, 4503.234450143484, 4538.092381523643, 4567.634589232854, 5235.764390602432, 5260.421353651095, 5282.788688452496, 5294.152935530374, 5298.311219541512, 4541.591256786905, 4565.657575681837, 4567.611753001032, 4577.359169716243, 4614.400127983341, 4562.703424277412, 4668.673192876466, 4719.221328480831, 4749.572538471554, 4750.904981900343, 4861.052094841472, 4906.656534042654, 4921.3356196912955, 4943.530364615356, 4995.950040499549, 5238.71187084714, 5238.921416178684, 5244.187150991603, 5247.763850626655, 5262.710550919736, 4808.495108013748, 4847.612191024639, 4903.730294833818, 4922.335484709519, 4979.0788704089855, 5142.51146141116, 5179.22311653255, 5182.637215394886, 5185.507376799198, 5222.42553319127, 5074.695518268915, 5228.790848366175, 5238.0833354162105, 5239.738013099253, 5243.711595862264, 4944.653874228769, 5008.348914641219, 5056.064628043824, 5119.48805119485, 5136.229565565046, 5062.392512898476, 5072.82245121419, 5078.238264260391, 5080.288759573588, 5108.157154069537, 4878.731669758197, 4956.256561515802, 4967.478414766542, 4975.651704380659, 4990.8752281193265, 5066.265391518283, 5133.358330208724, 5143.948560514347, 5157.329547158845, 5199.168133098686, 4935.16102262609, 4935.901281974412, 4939.036887806987, 4944.851654450228, 4946.505349465025], "value": 4766.387586228717, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.9971550142249, 595.2291782142127, 603.9883195647295, 613.1171113596422, 635.3265538529159, 32708.0, 33336.83331583342, 33434.66565334346, 33519.49720754191, 33559.16102097449, 36244.0, 36803.447948280795, 36811.631883681155, 36882.631173688256, 36913.815430922805, 7508.249175082503, 7748.380129589647, 7749.496282741604, 7750.496217745828, 7758.728444504443, 7577.962110189442, 7668.961655191716, 7688.654010569509, 7836.451448398614, 7862.724804631839, 7801.336886364666, 7816.609169541529, 7827.6868925242925, 7849.8037549061155, 7862.410319226053, 7772.533647981111, 7793.610319484032, 7808.60956952153, 7839.294463498312, 7867.606619669051, 7751.689932402697, 7817.413693972975, 7872.252136047066, 7875.566843823587, 7886.447948643598, 35384.11539711502, 35723.4641480378, 35833.82083089568, 35865.46201806975, 36023.819880900686, 2551.961720574193, 2936.9559456608167, 3063.234191452137, 3101.379724055198, 3118.158097313735, 23837.284881453583, 24017.27948161558, 24387.0, 24835.379115522075, 25130.371740706447, 3331.4003479373705, 3415.4535274355985, 3425.537552430415, 3449.4653328734084, 3501.4047611906035, 137848.0, 138221.0, 138792.0, 139215.0, 139488.30255848757, 30516.694833051828, 30711.846440767655, 30714.078577642707, 30764.0, 32662.673373265963, 31392.372152557276, 31496.055118346027, 31501.212469688442, 31782.364352712815, 31848.522272165937, 11139.33164010162, 11214.215004949576, 11247.66257012291, 11262.436878156059, 11281.774364512828, 9989.0, 9999.200063994864, 10054.396736195851, 10072.647457339104, 10083.092521673085, 7850.842983140419, 8062.113167551564, 8152.184781521919, 8180.345572354197, 8208.794780130545, 3208.246062175387, 3250.3174333390252, 3250.8049517029053, 3256.1859535116223, 3270.5421241026274, 913.2329733500284, 933.715216858851, 1003.9749006274756, 1006.054308949585, 1024.4672770159475, 27612.447751044867, 28024.43951120966, 28196.859015705202, 28269.43461130807, 28572.285692857844, 1030.253066526777, 1030.5517100061497, 1047.382044593678, 1050.238577031646, 1100.9779804404027, 14641.707165856624, 15032.323545440482, 15046.54860354191, 15198.544043678707, 15348.309326080353, 300895.0, 303527.0, 305866.0, 306535.0, 307038.0, 47421.0, 48147.0, 48197.0, 48248.27627585589, 48275.517244827104, 1199.0827017331749, 1208.7479899835203, 1234.370471059748, 1248.2073883084306, 1254.5483625894854, 26637.334066647712, 27772.86113569419, 27805.165845024683, 27846.44307113887, 28244.858775706813, 40956.18087638171, 40976.79511602423, 41583.37624935568, 41620.58379416167, 41646.0, 277495.0, 279125.0, 280011.0, 280264.5986770053, 280428.0, 24704.629430558198, 25400.0, 25409.87295063513, 25483.61774573346, 37636.435453468766, 39331.0, 39391.0, 40121.59878401295, 40539.18921621492, 40704.1859162821, 33910.66089339075, 33930.321393572485, 34027.65972340245, 34186.65813341934, 34422.82788586041, 32747.67252327446, 33032.33935321232, 33305.0, 33410.66589334173, 33755.493667594514, 32927.50608740919, 33185.170370740925, 36022.819885900404, 37054.8147259262, 37324.0, 27460.436323697788, 29211.415771684024, 29394.0, 29509.704902951555, 29602.407951841273, 23283.76716232816, 23470.295891123293, 23560.410989725395, 23964.40088997789, 23966.640500392856], "value": 15410.32953960372, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.2720408804874, 374.9193923306489, 378.4739212494632, 379.7626483447845, 388.0299251870324, 15622.218889055559, 16377.508674739747, 17433.91283043583, 17480.38818641348, 17481.475555733316, 15654.765178522332, 16023.0, 16377.83622163778, 16391.688664906807, 16392.180390980462, 5035.748212589365, 5181.481851814807, 5211.192265198882, 5216.0, 5226.843194704146, 3679.4848721179055, 5071.239314102896, 5587.413321601234, 5906.970465147669, 5918.526517878559, 5820.563457740665, 5821.912671309934, 5839.7664093436215, 5844.473997340238, 5877.059670452729, 5585.58108141889, 5883.38224486427, 5892.499137573312, 5906.0, 5910.34986151523, 4374.8906277343, 5106.131957567222, 5137.691738495702, 5143.3313669223135, 5172.612054095958, 11816.527338906433, 11998.560172779235, 12022.27866328023, 12032.39838008105, 12129.575464858775, 1780.97328540072, 1790.4181141129054, 1875.2499000399812, 1956.8043195680461, 2043.1214577731569, 8922.821543569156, 9131.589078491485, 9203.585838637277, 9364.43813371193, 9447.338686291961, 1673.9916300418543, 1692.9238184281737, 1730.2732852202105, 1731.994083930504, 1752.3165965273554, 64601.35398646, 65700.0, 67378.0, 67812.0, 68433.0, 9681.70954871355, 9832.60669573209, 9838.311318207656, 9864.704058878246, 9880.40717556949, 13613.931930340284, 13715.314234288246, 13723.45106195741, 13763.141975833334, 13772.65568360799, 6287.339829317947, 6347.460465860454, 6458.2895881453005, 6547.443467305332, 6573.309802470767, 5862.677552734555, 5881.206037184926, 5959.255093113361, 5970.462658360769, 6050.727717252734, 4187.392828039917, 4243.108947121139, 4276.08064266178, 4337.1976184405985, 4375.27807911691, 1655.6688662267354, 1738.1483073294248, 1772.3708083630383, 1828.186457026637, 1833.6149408624071, 904.3217586809892, 926.7914719188128, 939.6711151097061, 963.2775418436033, 989.223459584223, 10309.690709278733, 10515.0, 10748.462576871281, 10805.297655652357, 10927.562897484171, 393.1959143551444, 398.21154114852175, 399.81408644980223, 403.824336413661, 407.6779344318015, 5563.610547261653, 5584.301962254718, 5597.916031259534, 5627.521660658808, 5711.143328500758, 400509.0, 402533.0, 407199.0, 410001.0, 414662.0, 62489.37510624927, 73670.26329736634, 78918.0, 79816.0, 81001.0, 437.8445651793567, 453.36981595582165, 455.92249317616086, 458.24161013522007, 460.16939424339387, 9537.427754334485, 9648.469334186688, 10260.281780275309, 10421.374717516974, 10430.217733669853, 32753.672463275063, 32972.34055318928, 33404.33191336208, 34280.314393712484, 34680.13299667428, 46731.76634116808, 47482.0, 47734.0, 48309.41060599237, 48540.27189592088, 7364.189939106587, 7375.0, 7410.925890741024, 7434.702611895464, 7526.32263096324, 8856.937167539936, 9651.324407291422, 9960.701178964642, 10935.726606834893, 10988.560457581607, 8911.73264802057, 9026.007139214813, 9157.542122893961, 9254.537273136182, 9373.718788436357, 9404.764880878032, 9672.903270967201, 9868.161206297258, 9881.851772223567, 9964.352317099365, 9591.520423978634, 9841.26190535727, 9956.800863982824, 10028.799424011624, 10056.54745536438, 7479.36425403825, 7556.962215188889, 7610.353119984863, 7656.234376562299, 7704.499207551491, 7635.503692259986, 9610.95194524023, 9895.25785566071, 10066.848997265193, 10173.135283500986], "value": 7279.002144510507, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1439.625697318697, 1472.683373074789, 1599.608096016476, 1762.7444020617004, 1802.9729554056682, 6817.863642727142, 7369.926300736991, 7394.44541659375, 7590.924090759091, 7613.695452181913, 7458.366038886687, 7460.104787425503, 7469.178390377054, 7501.774946751606, 7540.585267810268, 2232.6651002349613, 2246.932592022242, 2254.5265494246228, 2265.0486795545826, 2265.8980345884474, 2102.6320393931, 2138.818200452956, 2141.6038032963875, 2156.9892150539226, 2164.037003533428, 2201.086549082129, 2211.900464479102, 2223.0885337011828, 2245.012194634364, 2256.537409830981, 2188.3544354415485, 2191.3316438486254, 2191.5288213034273, 2191.9890400548056, 2193.56128774245, 2155.8275337972923, 2173.9021744021557, 2178.6514157734846, 2182.6725991101302, 2191.791779780918, 7622.123455802598, 7637.656305466267, 7663.31030207284, 7731.652075656552, 7739.0, 4386.517483076859, 4541.523140070278, 4546.840860569897, 4568.817247310104, 4597.908041839178, 2935.618369611937, 2950.2476868398635, 3056.3734434440885, 3069.570260163579, 3115.2834847984864, 922.4327038871113, 932.2029664636706, 945.5650400815633, 947.7725345916999, 956.9712908612684, 10370.740731481697, 10440.895591044069, 10458.79082418355, 10459.006394392596, 10537.262391632588, 4163.167366526707, 4222.577742225752, 4348.695591308578, 4458.108378324348, 4465.330200469891, 8986.820263594691, 8995.77510562228, 9045.909540904639, 9071.228945539571, 9079.68221112258, 4644.605208557243, 4646.79089440976, 4675.532446755297, 4680.438347398334, 4680.765961701902, 3684.778913265159, 4041.535223449282, 4172.102997855475, 4203.894902627398, 4215.430916826251, 3614.530111085542, 3674.81625918703, 3743.47591337213, 3748.156664750409, 3787.0721673189696, 1237.55448038706, 1253.5048655780915, 1266.7213213093105, 1267.0243912187564, 1278.8273583066352, 965.4255717847869, 985.0986347491964, 986.127277359542, 1054.9103326217205, 1240.9379531023412, 7103.644817759091, 7179.461540384492, 7255.600941948243, 7287.307705767944, 7328.633568321563, 421.82915919052834, 459.1162013124721, 459.6162204559164, 461.9053094115698, 466.4915242385816, 5517.282753242052, 5599.944000560024, 5602.522278803297, 5606.159076138611, 5649.6327738696855, 9077.137671921157, 9513.33406661527, 9533.52332383378, 9536.90463095374, 9541.809163816684, 9080.591373388213, 9357.485338306322, 9392.718218453458, 9441.300565898204, 9462.810743785085, 7043.8239044023285, 7163.06880105583, 7180.497365184387, 7193.388561972186, 7197.100362454693, 7123.893141602776, 7154.676384868816, 7204.639768011683, 7277.417806575355, 7327.4504412168235, 8331.6667333306, 8505.979282486142, 8514.872276915727, 8539.444936079135, 8635.740927772176, 8483.957580212307, 8613.22480976715, 8768.342374321825, 8796.692115776174, 8903.3322500814, 5991.64050156992, 6620.205575330991, 6817.7272909083085, 6847.93152068473, 6912.308769123048, 7249.855002900018, 7306.232845551353, 7372.889406659012, 7379.667914943733, 7387.2243414442855, 6534.771283005072, 6687.966560167362, 6766.255711871789, 6801.965990170018, 6817.2501024888215, 6572.737090516517, 6630.53586248958, 6660.234073081658, 6698.263191049078, 6722.865542689216, 7025.0516180317045, 7042.190148133031, 7061.329173728487, 7123.038389817309, 7125.501214914906, 6503.772367967098, 6552.901706474502, 6567.802965911031, 6568.113304703804, 6585.0, 6499.837504062436, 6592.340765923369, 6626.403623673892, 6629.569078009914, 6632.535722499379], "value": 4313.128956234638, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.5461807289066, 305.47763324714737, 310.5450514995531, 312.4937601086241, 317.1168296294819, 5206.323177986861, 5316.49493298137, 5329.653572517794, 5369.62412631116, 5387.784488620456, 5232.764525596348, 5246.737663116838, 5255.500727430888, 5266.868328291795, 5277.8416647500635, 3871.59348268432, 3986.7807270600106, 4083.7549747015128, 4107.958920410802, 4130.690198235129, 4069.470968774055, 4077.938830917539, 4091.590840915914, 4092.1994322498153, 4103.774292413916, 4072.287349713803, 4074.5314288856716, 4075.0, 4076.9184616307657, 4092.427060211558, 3965.9801700991597, 4056.411820286057, 4061.390791381287, 4066.3087275163293, 4078.3066878630407, 3598.604153543108, 3603.1532589841368, 3609.079684680416, 3611.855525778966, 3617.385044542434, 5030.0, 5040.722760248185, 5049.34358533392, 5062.797488100471, 5073.518015788494, 4549.795259213311, 4704.411948506402, 4708.058388322315, 4713.397444868761, 4723.504032076617, 5514.448555144493, 5525.668459892379, 5526.932552433398, 5544.417836127189, 5551.639143455663, 3901.1027463683226, 3908.9413658795143, 3911.5892831252877, 3916.1580260244186, 3918.804059797027, 5442.23808666783, 5827.737751801179, 5835.679037652927, 5846.356900740915, 5851.4148585141575, 3877.418387241936, 3883.1068854163136, 3902.551206611219, 3911.946228230202, 3926.9018274543364, 3949.0, 3969.6030396960073, 3973.2450834341385, 3981.482407287092, 3987.063040185554, 4558.6581006423985, 4567.429071366079, 4568.908621827545, 4583.083383323348, 4585.426821647294, 5278.762455689503, 5496.422875598085, 5535.972320138373, 5556.194351818964, 5579.553635709133, 1421.3959067396315, 1421.6872288096602, 1434.4907557817032, 1449.1884544655027, 1449.3767679897535, 926.8517037274004, 958.3357681294933, 970.1801977329145, 988.9901100989042, 997.1623835977668, 4752.619790416758, 4892.461829198785, 4925.655204135676, 4927.310176575283, 4938.456769755324, 5731.484166425042, 5786.739596718157, 5806.506446952057, 5806.593538452352, 5818.854528636818, 4823.9517604824205, 4870.220764677634, 4914.557689807934, 4932.876678083005, 4936.456989731127, 3072.938541229163, 3084.6606873243927, 3085.167004908707, 3101.65881753007, 3103.90688279352, 5396.514313711785, 5420.322459692538, 5428.9185662215095, 5436.238926550286, 5440.863978400572, 5711.8000869969355, 5839.248225532323, 5887.558433117448, 5936.9406305937255, 5947.791827286024, 5355.625106242604, 5388.0, 5391.196577779533, 5397.244385786072, 5404.243405923174, 5448.318960129984, 5738.454846789548, 5758.856028599319, 5773.278340207474, 5779.797707080232, 5657.519110875622, 5672.688002159921, 5679.460451257124, 5693.800716974886, 5707.771689132388, 5428.6199966002005, 5450.8909821802545, 5461.918071228855, 5463.48096930791, 5488.039593071277, 3889.649931506178, 3899.590542992945, 3957.6635985941516, 3960.900977475471, 3992.4410582519054, 5705.657660540381, 5740.196372507936, 5750.482456578928, 5753.280839895013, 5802.535797136304, 5532.814538257447, 5569.415211402745, 5587.217789509391, 5595.804146854841, 5596.104623260258, 5411.621186516906, 5496.31296087989, 5545.3622833374675, 5556.861078473071, 5589.133684278943, 5454.290942177491, 5462.3445186577865, 5482.671039737628, 5488.121900495901, 5502.339719233558, 5269.604779641466, 5416.8104116355735, 5603.915941260802, 5607.579431542732, 5610.326760788732, 5457.0995785696505, 5457.645253058538, 5468.234447177478, 5469.398366179637, 5469.453054694499], "value": 4165.01790893922, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [681.4207923265224, 681.7955608639396, 776.4758787818221, 778.7858338956786, 783.1502819440906, 12351.073669474792, 12510.0, 12527.0, 12682.682932926682, 12685.238885666866, 12595.559155429562, 13177.538786142486, 13213.471461141542, 13274.20354778714, 13278.070535062525, 651.8174911024921, 811.6185392865344, 812.3866480807012, 818.1368656067846, 819.4018366592361, 792.9246721561442, 817.9836403271931, 818.3248819723722, 818.3657665309373, 819.2994989284166, 857.1043259793499, 857.1985193843776, 865.0441262405046, 868.2619773192798, 870.0299166429448, 855.7561095087901, 858.5964596639539, 860.1527495417009, 863.046333801147, 863.9222469977669, 631.826247781859, 636.141209367355, 637.9489640828723, 638.1894993358455, 638.7157714816908, 12861.228326300452, 12913.289769062698, 12913.741725165444, 12930.224186548838, 12934.159279646887, 12603.621891343275, 12604.558840440632, 12633.684157896034, 12651.683707907285, 12811.743765124738, 9679.903200968041, 9791.902080979242, 9889.406635601816, 10151.340162889388, 10319.0, 3335.232896433834, 3361.781484203519, 3374.797512149279, 3435.2442462658173, 3456.6370531094126, 46979.29531057037, 47336.76331618354, 47902.52097479015, 48028.75985620049, 48392.75803620995, 9877.703668889944, 10037.447940363205, 10048.949755251324, 10145.847812282822, 10147.441890696082, 16758.32966681319, 16878.0, 16901.91549042247, 16904.0, 16910.32358705638, 6811.012403201607, 6974.4420446364165, 7007.0, 7016.894746578805, 7167.534110282815, 3804.505414296124, 3816.866409675648, 3817.5991520889906, 3867.323218436762, 3913.4325522799036, 2952.143878275319, 3036.6659667436566, 3042.3154790172475, 3046.8628911699025, 3053.603031605877, 521.6087934049463, 532.0502902319341, 533.6797921247298, 537.760696490066, 543.2204786131913, 497.57954528423426, 530.4218401941902, 542.9131338985743, 598.9281286245591, 613.3804857094367, 7776.0, 8104.27061564462, 8246.628901699438, 8332.33341332692, 8520.74437766868, 481.8000529780172, 560.7112337146373, 576.7548791763484, 589.0104624231247, 651.495091304243, 3682.9447558286647, 3804.505414296124, 3861.7876016819346, 3871.7289789715014, 3946.546147193052, 47699.0, 47804.5219547807, 47813.0, 48161.5183848164, 49155.01689966252, 43654.0, 44066.55933440624, 44289.0, 44506.0, 44660.55339446629, 41272.0, 41282.1743565127, 41590.584094159276, 42121.36817947733, 42121.578784212994, 7619.733309334147, 7664.6550905210515, 7705.730299439717, 7752.612369381395, 7862.960685196537, 28303.858480707466, 28336.291592710346, 28491.28771780722, 28755.13734587966, 28893.0, 34453.82773086119, 35012.64987350094, 35143.47284790679, 35252.647473524936, 35994.28011439809, 10798.568057277935, 10835.404052777172, 10840.186985976241, 10922.634670666166, 11165.609203677832, 12044.061464057446, 12183.939080304543, 12294.81557776652, 12318.938405307916, 12319.322437266037, 10795.082417994558, 10811.6215932442, 10952.233343665866, 11699.532018719156, 11865.644030679094, 11314.191468625966, 11420.600278990196, 11566.19036667459, 11606.94196529012, 11672.824907626222, 10573.154147668321, 10625.415602141647, 10760.569577216824, 10798.138354555507, 11080.168987325822, 8982.775430614287, 9093.181613654802, 9105.453672779655, 9401.153896149379, 9603.711888643353, 9661.864537242564, 9714.174295184988, 9793.265505087005, 9805.607775689177, 9936.950315248667], "value": 5964.174889448811, "unit": "score"}], "name": "dromaeo_css", "value": 6208.8567985723, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 115.0, 113.0, 115.0, 133.0, 114.0, 113.0, 114.0, 115.0], "value": 116.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 135.0, 154.0, 195.0, 134.0, 164.0, 158.0, 133.0, 190.0, 134.0], "value": 155.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 162.0, 165.0, 166.0, 167.0, 166.0, 165.0, 162.0, 165.0, 162.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 72.0, 153.0, 76.0, 78.0, 77.0, 73.0, 151.0, 76.0], "value": 90.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 156.0, 95.0, 94.0, 94.0, 133.0, 95.0, 95.0, 146.0], "value": 109.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 124.0, 118.0, 118.0, 117.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 147.0, 147.0, 147.0, 148.0, 147.0, 148.0, 146.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 98.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 97.0], "value": 96.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 66.0, 64.0, 64.0, 65.0, 83.0, 63.0, 63.0], "value": 65.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 65.0, 65.0, 63.0, 63.0, 64.0, 65.0, 64.0], "value": 64.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 90.0, 90.0, 88.0, 94.0, 93.0, 87.0, 86.0, 86.0], "value": 88.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 154.0, 144.0, 151.0, 140.0, 143.0, 140.0, 141.0, 175.0, 151.0], "value": 148.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 177.0, 173.0, 181.0, 175.0, 175.0, 170.0, 172.0, 174.0, 176.0], "value": 175.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 72.0, 72.0, 73.0, 73.0, 72.0, 71.0, 72.0, 74.0], "value": 72.1, "unit": "score"}], "name": "kraken", "value": 1613.0, "alertThreshold": 2.0}]} 16:19:51 INFO - Return code: 0 16:19:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:19:51 ERROR - # TBPL SUCCESS # 16:19:51 INFO - Running post-action listener: _resource_record_post_action 16:19:51 INFO - Running post-run listener: _resource_record_post_run 16:19:52 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 12288; Write bytes: 530128896; Read time: 544; Write time: 1050688 16:19:52 INFO - install - Wall time: 16s; CPU: 17.0%; Read bytes: 0; Write bytes: 233529344; Read time: 0; Write time: 616288 16:19:52 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 12288; Write bytes: 296599552; Read time: 544; Write time: 434400 16:19:52 INFO - Running post-run listener: _upload_blobber_files 16:19:52 INFO - Blob upload gear active. 16:19:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:19:52 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:19:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:19:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:19:53 INFO - (blobuploader) - INFO - Open directory for files ... 16:19:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:19:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:19:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:19:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:19:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:19:53 INFO - (blobuploader) - INFO - Done attempting. 16:19:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:19:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:19:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:19:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:19:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:19:54 INFO - (blobuploader) - INFO - Done attempting. 16:19:54 INFO - (blobuploader) - INFO - Iteration through files over. 16:19:54 INFO - Return code: 0 16:19:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:19:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:19:54 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/61b0a93d72d722af53d0bfe02e8b743effe59a005599b7c5bded7c007dde9f85d8733ba32510f992d4b85bb5bca5d79d13d195bf3f1fc0bd47e52ddb05269a3a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e072b91a414a87706cc2f5a8ef67cd50da95f09f42d379c3b755180eed2d77132256b6b593eb0fdbe76f82b8061ad00e159dc87b540555910e8bb34b5701859a"} 16:19:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:19:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:19:54 INFO - Contents: 16:19:54 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/61b0a93d72d722af53d0bfe02e8b743effe59a005599b7c5bded7c007dde9f85d8733ba32510f992d4b85bb5bca5d79d13d195bf3f1fc0bd47e52ddb05269a3a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e072b91a414a87706cc2f5a8ef67cd50da95f09f42d379c3b755180eed2d77132256b6b593eb0fdbe76f82b8061ad00e159dc87b540555910e8bb34b5701859a"} 16:19:54 INFO - Running post-run listener: copy_logs_to_upload_dir 16:19:54 INFO - Copying logs to upload dir... 16:19:54 INFO - mkdir: /builds/slave/test/build/upload/logs 16:19:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.672876 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-04-12 16:19:54.748171) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-12 16:19:54.751416) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1460501829.630477-1507377035 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/61b0a93d72d722af53d0bfe02e8b743effe59a005599b7c5bded7c007dde9f85d8733ba32510f992d4b85bb5bca5d79d13d195bf3f1fc0bd47e52ddb05269a3a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e072b91a414a87706cc2f5a8ef67cd50da95f09f42d379c3b755180eed2d77132256b6b593eb0fdbe76f82b8061ad00e159dc87b540555910e8bb34b5701859a"} build_url:https://queue.taskcluster.net/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011446 build_url: 'https://queue.taskcluster.net/v1/task/SSkCCnGZT5SqYvlDm0Wa2w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/61b0a93d72d722af53d0bfe02e8b743effe59a005599b7c5bded7c007dde9f85d8733ba32510f992d4b85bb5bca5d79d13d195bf3f1fc0bd47e52ddb05269a3a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e072b91a414a87706cc2f5a8ef67cd50da95f09f42d379c3b755180eed2d77132256b6b593eb0fdbe76f82b8061ad00e159dc87b540555910e8bb34b5701859a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-12 16:19:54.776160) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 16:19:54.776462) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1460501829.630477-1507377035 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004436 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 16:19:54.861994) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-12 16:19:54.862325) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-12 16:19:54.862625) ========= ========= Total master_lag: 0.27 =========