builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-055 starttime: 1460178371.31 results: success (0) buildid: 20160408213953 builduid: 4c4c95a0875f4b309cfe650acfb4b3e2 revision: ca3f8c085a584d804511d9a551e95606fc8ff41d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-08 22:06:11.314866) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-08 22:06:11.315749) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-08 22:06:11.316079) ========= 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=82e07478c745e68b1fe4678a000001bc-1460176016.863940-1474057227 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006345 basedir: '/builds/slave/test' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-08 22:06:11.378767) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-08 22:06:11.379084) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-08 22:06:11.402002) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 22:06:11.402280) ========= 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=82e07478c745e68b1fe4678a000001bc-1460176016.863940-1474057227 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004586 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 22:06:11.452606) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-08 22:06:11.452920) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-08 22:06:11.453306) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 22:06:11.453620) ========= 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=82e07478c745e68b1fe4678a000001bc-1460176016.863940-1474057227 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-08 22:06:12-- 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% 114M=0s 2016-04-08 22:06:12 (114 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.173669 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 22:06:11.643042) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 22:06:11.643676) ========= 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=82e07478c745e68b1fe4678a000001bc-1460176016.863940-1474057227 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017581 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 22:06:11.697136) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 22:06:11.697869) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ca3f8c085a584d804511d9a551e95606fc8ff41d --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 ca3f8c085a584d804511d9a551e95606fc8ff41d --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=82e07478c745e68b1fe4678a000001bc-1460176016.863940-1474057227 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-08 22:06:12,676 truncating revision to first 12 chars 2016-04-08 22:06:12,676 Setting DEBUG logging. 2016-04-08 22:06:12,676 attempt 1/10 2016-04-08 22:06:12,676 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ca3f8c085a58?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-08 22:06:13,024 unpacking tar archive at: fx-team-ca3f8c085a58/testing/mozharness/ program finished with exit code 0 elapsedTime=0.643938 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 22:06:12.362253) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-08 22:06:12.363021) ========= echo ca3f8c085a584d804511d9a551e95606fc8ff41d in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'ca3f8c085a584d804511d9a551e95606fc8ff41d'] 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=82e07478c745e68b1fe4678a000001bc-1460176016.863940-1474057227 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False ca3f8c085a584d804511d9a551e95606fc8ff41d program finished with exit code 0 elapsedTime=0.004725 script_repo_revision: 'ca3f8c085a584d804511d9a551e95606fc8ff41d' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-08 22:06:12.421720) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-08 22:06:12.422401) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-08 22:06:12.434319) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-04-08 22:06:12.434943) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=82e07478c745e68b1fe4678a000001bc-1460176016.863940-1474057227 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:06:13 INFO - MultiFileLogger online at 20160408 22:06:13 in /builds/slave/test 22:06:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 22:06:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:06:13 INFO - {'append_to_log': False, 22:06:13 INFO - 'base_work_dir': '/builds/slave/test', 22:06:13 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 22:06:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:06:13 INFO - 'branch': 'Fx-Team-Non-PGO', 22:06:13 INFO - 'buildbot_json_path': 'buildprops.json', 22:06:13 INFO - 'config_files': ('talos/linux_config.py',), 22:06:13 INFO - 'default_actions': ('clobber', 22:06:13 INFO - 'read-buildbot-config', 22:06:13 INFO - 'download-and-extract', 22:06:13 INFO - 'populate-webroot', 22:06:13 INFO - 'create-virtualenv', 22:06:13 INFO - 'install', 22:06:13 INFO - 'run-tests'), 22:06:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:06:13 INFO - 'download_minidump_stackwalk': True, 22:06:13 INFO - 'download_symbols': 'ondemand', 22:06:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:06:13 INFO - 'tooltool.py': '/tools/tooltool.py', 22:06:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:06:13 INFO - '/tools/misc-python/virtualenv.py')}, 22:06:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:06:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:06:13 INFO - 'installer_path': 'installer.exe', 22:06:13 INFO - 'log_level': 'info', 22:06:13 INFO - 'log_name': 'talos', 22:06:13 INFO - 'log_to_console': True, 22:06:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:06:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:06:13 INFO - 'opt_config_files': (), 22:06:13 INFO - 'pip_index': False, 22:06:13 INFO - 'sps_profile': False, 22:06:13 INFO - 'sps_profile_interval': 0, 22:06:13 INFO - 'suite': 'dromaeojs', 22:06:13 INFO - 'system_bits': '32', 22:06:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:06:13 INFO - 'title': 'talos-linux64-ix-055', 22:06:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:06:13 INFO - 'use_talos_json': True, 22:06:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:06:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:06:13 INFO - 'work_dir': 'build'} 22:06:13 INFO - ##### 22:06:13 INFO - ##### Running clobber step. 22:06:13 INFO - ##### 22:06:13 INFO - Running pre-action listener: _resource_record_pre_action 22:06:13 INFO - Running main action method: clobber 22:06:13 INFO - rmtree: /builds/slave/test/build 22:06:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:06:13 INFO - Running post-action listener: _resource_record_post_action 22:06:13 INFO - ##### 22:06:13 INFO - ##### Running read-buildbot-config step. 22:06:13 INFO - ##### 22:06:13 INFO - Running pre-action listener: _resource_record_pre_action 22:06:13 INFO - Running main action method: read_buildbot_config 22:06:13 INFO - Using buildbot properties: 22:06:13 INFO - { 22:06:13 INFO - "project": "", 22:06:13 INFO - "product": "firefox", 22:06:13 INFO - "script_repo_revision": "production", 22:06:13 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 22:06:13 INFO - "repository": "", 22:06:13 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 22:06:13 INFO - "buildid": "20160408213953", 22:06:13 INFO - "pgo_build": "False", 22:06:13 INFO - "basedir": "/builds/slave/test", 22:06:13 INFO - "buildnumber": 2792, 22:06:13 INFO - "slavename": "talos-linux64-ix-055", 22:06:13 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:06:13 INFO - "platform": "ubuntu64_hw", 22:06:13 INFO - "scheduler": "tests-fx-team-linux64-talos", 22:06:13 INFO - "branch": "fx-team", 22:06:13 INFO - "repo_path": "integration/fx-team", 22:06:13 INFO - "revision": "ca3f8c085a584d804511d9a551e95606fc8ff41d", 22:06:13 INFO - "stage_platform": "linux64", 22:06:13 INFO - "builduid": "4c4c95a0875f4b309cfe650acfb4b3e2", 22:06:13 INFO - "slavebuilddir": "test" 22:06:13 INFO - } 22:06:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 22:06:13 INFO - Running post-action listener: _resource_record_post_action 22:06:13 INFO - ##### 22:06:13 INFO - ##### Running download-and-extract step. 22:06:13 INFO - ##### 22:06:13 INFO - Running pre-action listener: _resource_record_pre_action 22:06:13 INFO - Running main action method: download_and_extract 22:06:13 INFO - mkdir: /builds/slave/test/build/tests 22:06:13 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')]} 22:06:13 INFO - https://queue.taskcluster.net/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:06:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:06:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:06:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/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 22:06:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/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 22:06:15 INFO - Downloaded 1361 bytes. 22:06:15 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:06:15 INFO - Using the following test package requirements: 22:06:15 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:06:15 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:06:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:06:15 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:06:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:06:15 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:06:15 INFO - u'jsshell-linux-x86_64.zip'], 22:06:15 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:06:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:06:15 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:06:15 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:06:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:06:15 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:06:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:06:15 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:06:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:06:15 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:06:15 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:06:15 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:06: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')]} 22:06:15 INFO - https://queue.taskcluster.net/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:06:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:06:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:06:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/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 22:06:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/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 22:06:17 INFO - Downloaded 22186314 bytes. 22:06: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'] 22:06: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 22:06:19 INFO - Return code: 0 22:06:19 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 22:06:19 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')]} 22:06:19 INFO - https://queue.taskcluster.net/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:06:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:06:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:06:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/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 22:06:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/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 22:06:37 INFO - Downloaded 22186314 bytes. 22:06:37 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'] 22:06:37 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 22:06:38 INFO - Return code: 0 22:06: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')]} 22:06:38 INFO - https://queue.taskcluster.net/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:06:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:06:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:06:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/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 22:06:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/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 22:06:40 INFO - Downloaded 10847693 bytes. 22:06:40 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'] 22:06:40 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 22:06:40 INFO - Return code: 0 22:06:40 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')]} 22:06:40 INFO - https://queue.taskcluster.net/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:06:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:06:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:06:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/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 22:06:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/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 22:06:41 INFO - Downloaded 54052336 bytes. 22:06:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:06:41 INFO - mkdir: /builds/slave/test/properties 22:06:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:06:41 INFO - Writing to file /builds/slave/test/properties/build_url 22:06:41 INFO - Contents: 22:06:41 INFO - build_url:https://queue.taskcluster.net/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:06:42 INFO - Running post-action listener: _resource_record_post_action 22:06:42 INFO - Running post-action listener: set_extra_try_arguments 22:06:42 INFO - ##### 22:06:42 INFO - ##### Running populate-webroot step. 22:06:42 INFO - ##### 22:06:42 INFO - Running pre-action listener: _resource_record_pre_action 22:06:42 INFO - Running main action method: populate_webroot 22:06:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:06:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:06:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:06:42 INFO - '--tppagecycles', 22:06:42 INFO - '7'], 22:06:42 INFO - 'tests': ['tsvgm']}}, 22:06:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:06:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:06:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:06:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:06:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:06:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:06:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:06:42 INFO - 'talos_options': ['--disable-e10s'], 22:06:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:06:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:06:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:06:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:06:42 INFO - 'talos_options': ['--disable-e10s'], 22:06:42 INFO - 'tests': ['damp', 'tps']}, 22:06:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:06:42 INFO - 'tests': ['damp', 'tps']}, 22:06:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:06:42 INFO - 'tests': ['dromaeo_dom']}, 22:06:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:06:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:06:42 INFO - 'tests': ['a11yr', 22:06:42 INFO - 'ts_paint', 22:06:42 INFO - 'tpaint', 22:06:42 INFO - 'sessionrestore', 22:06:42 INFO - 'sessionrestore_no_auto_restore', 22:06:42 INFO - 'tabpaint']}, 22:06:42 INFO - 'other-e10s': {'tests': ['a11yr', 22:06:42 INFO - 'ts_paint', 22:06:42 INFO - 'tpaint', 22:06:42 INFO - 'sessionrestore', 22:06:42 INFO - 'sessionrestore_no_auto_restore', 22:06:42 INFO - 'tabpaint']}, 22:06:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:06:42 INFO - 'ts_paint', 22:06:42 INFO - 'tpaint', 22:06:42 INFO - 'sessionrestore', 22:06:42 INFO - 'sessionrestore_no_auto_restore', 22:06:42 INFO - 'tabpaint']}, 22:06:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:06:42 INFO - 'ts_paint', 22:06:42 INFO - 'tpaint', 22:06:42 INFO - 'sessionrestore', 22:06:42 INFO - 'sessionrestore_no_auto_restore', 22:06:42 INFO - 'tabpaint']}, 22:06:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:06:42 INFO - 'tests': ['a11yr', 22:06:42 INFO - 'ts_paint', 22:06:42 INFO - 'tpaint', 22:06:42 INFO - 'sessionrestore', 22:06:42 INFO - 'sessionrestore_no_auto_restore', 22:06:42 INFO - 'tabpaint']}, 22:06:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:06:42 INFO - 'tests': ['a11yr', 22:06:42 INFO - 'ts_paint', 22:06:42 INFO - 'tpaint', 22:06:42 INFO - 'sessionrestore', 22:06:42 INFO - 'sessionrestore_no_auto_restore', 22:06:42 INFO - 'tabpaint']}, 22:06:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:06:42 INFO - 'tests': ['tsvgx', 22:06:42 INFO - 'tsvgr_opacity', 22:06:42 INFO - 'tart', 22:06:42 INFO - 'tscrollx', 22:06:42 INFO - 'cart']}, 22:06:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:06:42 INFO - 'tsvgr_opacity', 22:06:42 INFO - 'tart', 22:06:42 INFO - 'tscrollx', 22:06:42 INFO - 'cart']}, 22:06:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:06:42 INFO - 'talos_options': ['--disable-e10s'], 22:06:42 INFO - 'tests': ['tp5o']}, 22:06:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:06:42 INFO - 'tests': ['tp5o']}, 22:06:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:06:42 INFO - 'talos_options': ['--disable-e10s', 22:06:42 INFO - '--xperf_path', 22:06:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:06:42 INFO - 'tests': ['tp5n']}, 22:06:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:06:42 INFO - 'talos_options': ['--xperf_path', 22:06:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:06:42 INFO - 'tests': ['tp5n']}}, 22:06:42 INFO - 'talos.zip': {'path': '', 22:06:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:06:42 INFO - Running post-action listener: _resource_record_post_action 22:06:42 INFO - ##### 22:06:42 INFO - ##### Running create-virtualenv step. 22:06:42 INFO - ##### 22:06:42 INFO - Running pre-action listener: _resource_record_pre_action 22:06:42 INFO - Running main action method: create_virtualenv 22:06:42 INFO - Creating virtualenv /builds/slave/test/build/venv 22:06:42 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 22:06:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:06:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:06:42 INFO - Using real prefix '/usr' 22:06:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:06:43 INFO - Installing distribute.............................................................................................................................................................................................done. 22:06:44 INFO - Installing pip.................done. 22:06:44 INFO - Return code: 0 22:06:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:06: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')]} 22:06:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:06:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06: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')]} 22:06:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:06:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06:44 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 0x7fa595697f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe385a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec7410>, '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 0xec8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec87a0>, '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': '82e07478c745e68b1fe4678a000001bc-1460176016.863940-1474057227', '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 22:06:44 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 22:06:44 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 22:06:44 INFO - Using env: {'DISPLAY': ':0', 22:06:44 INFO - 'HOME': '/home/cltbld', 22:06:44 INFO - 'LANG': 'en_US.UTF-8', 22:06:44 INFO - 'LANGUAGE': 'en_US:en', 22:06:44 INFO - 'LOGNAME': 'cltbld', 22:06:44 INFO - 'MAIL': '/var/mail/cltbld', 22:06:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:06:44 INFO - 'MOZ_NO_REMOTE': '1', 22:06:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:06:44 INFO - 'NO_EM_RESTART': '1', 22:06:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:06:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:06:44 INFO - 'PWD': '/builds/slave/test', 22:06:44 INFO - 'SHELL': '/bin/bash', 22:06:44 INFO - 'SHLVL': '1', 22:06:44 INFO - 'TERM': 'linux', 22:06:44 INFO - 'TMOUT': '86400', 22:06:44 INFO - 'USER': 'cltbld', 22:06:44 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1460176016.863940-1474057227', 22:06:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:06:44 INFO - '_': '/tools/buildbot/bin/python'} 22:06:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:06:45 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 22:06:45 INFO - Cleaning up... 22:06:45 INFO - Return code: 0 22:06:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:06:45 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')]} 22:06:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:06:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06:45 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')]} 22:06:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:06:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06:45 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 0x7fa595697f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe385a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec7410>, '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 0xec8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec87a0>, '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': '82e07478c745e68b1fe4678a000001bc-1460176016.863940-1474057227', '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 22:06:45 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 22:06:45 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 22:06:45 INFO - Using env: {'DISPLAY': ':0', 22:06:45 INFO - 'HOME': '/home/cltbld', 22:06:45 INFO - 'LANG': 'en_US.UTF-8', 22:06:45 INFO - 'LANGUAGE': 'en_US:en', 22:06:45 INFO - 'LOGNAME': 'cltbld', 22:06:45 INFO - 'MAIL': '/var/mail/cltbld', 22:06:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:06:45 INFO - 'MOZ_NO_REMOTE': '1', 22:06:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:06:45 INFO - 'NO_EM_RESTART': '1', 22:06:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:06:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:06:45 INFO - 'PWD': '/builds/slave/test', 22:06:45 INFO - 'SHELL': '/bin/bash', 22:06:45 INFO - 'SHLVL': '1', 22:06:45 INFO - 'TERM': 'linux', 22:06:45 INFO - 'TMOUT': '86400', 22:06:45 INFO - 'USER': 'cltbld', 22:06:45 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1460176016.863940-1474057227', 22:06:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:06:45 INFO - '_': '/tools/buildbot/bin/python'} 22:06:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:06:45 INFO - Downloading/unpacking psutil>=0.7.1 22:06:45 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 22:06:45 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 22:06:45 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 22:06:45 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 22:06:45 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 22:06:45 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 22:06:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:06:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:06:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:06:47 INFO - Installing collected packages: psutil 22:06:47 INFO - Running setup.py install for psutil 22:06:47 INFO - building 'psutil._psutil_linux' extension 22:06:47 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 22:06:47 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 22:06:47 INFO - building 'psutil._psutil_posix' extension 22:06:47 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 22:06:47 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 22:06:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:06:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:06:47 INFO - Successfully installed psutil 22:06:47 INFO - Cleaning up... 22:06:47 INFO - Return code: 0 22:06:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:06:47 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')]} 22:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:06:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06:47 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')]} 22:06:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:06:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06:47 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 0x7fa595697f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe385a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec7410>, '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 0xec8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec87a0>, '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': '82e07478c745e68b1fe4678a000001bc-1460176016.863940-1474057227', '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 22:06:47 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 22:06:47 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 22:06:47 INFO - Using env: {'DISPLAY': ':0', 22:06:47 INFO - 'HOME': '/home/cltbld', 22:06:47 INFO - 'LANG': 'en_US.UTF-8', 22:06:47 INFO - 'LANGUAGE': 'en_US:en', 22:06:47 INFO - 'LOGNAME': 'cltbld', 22:06:47 INFO - 'MAIL': '/var/mail/cltbld', 22:06:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:06:47 INFO - 'MOZ_NO_REMOTE': '1', 22:06:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:06:47 INFO - 'NO_EM_RESTART': '1', 22:06:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:06:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:06:47 INFO - 'PWD': '/builds/slave/test', 22:06:47 INFO - 'SHELL': '/bin/bash', 22:06:47 INFO - 'SHLVL': '1', 22:06:47 INFO - 'TERM': 'linux', 22:06:47 INFO - 'TMOUT': '86400', 22:06:47 INFO - 'USER': 'cltbld', 22:06:47 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1460176016.863940-1474057227', 22:06:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:06:47 INFO - '_': '/tools/buildbot/bin/python'} 22:06:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:06:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:06:48 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 22:06:48 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 22:06:48 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 22:06:48 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 22:06:48 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 22:06:48 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 22:06:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:06:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:06:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:06:50 INFO - Installing collected packages: mozsystemmonitor 22:06:50 INFO - Running setup.py install for mozsystemmonitor 22:06:50 INFO - Successfully installed mozsystemmonitor 22:06:50 INFO - Cleaning up... 22:06:50 INFO - Return code: 0 22:06:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:06:50 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')]} 22:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:06:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06:50 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')]} 22:06:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:06:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06:50 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 0x7fa595697f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe385a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec7410>, '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 0xec8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec87a0>, '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': '82e07478c745e68b1fe4678a000001bc-1460176016.863940-1474057227', '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 22:06:50 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 22:06:50 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 22:06:50 INFO - Using env: {'DISPLAY': ':0', 22:06:50 INFO - 'HOME': '/home/cltbld', 22:06:50 INFO - 'LANG': 'en_US.UTF-8', 22:06:50 INFO - 'LANGUAGE': 'en_US:en', 22:06:50 INFO - 'LOGNAME': 'cltbld', 22:06:50 INFO - 'MAIL': '/var/mail/cltbld', 22:06:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:06:50 INFO - 'MOZ_NO_REMOTE': '1', 22:06:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:06:50 INFO - 'NO_EM_RESTART': '1', 22:06:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:06:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:06:50 INFO - 'PWD': '/builds/slave/test', 22:06:50 INFO - 'SHELL': '/bin/bash', 22:06:50 INFO - 'SHLVL': '1', 22:06:50 INFO - 'TERM': 'linux', 22:06:50 INFO - 'TMOUT': '86400', 22:06:50 INFO - 'USER': 'cltbld', 22:06:50 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1460176016.863940-1474057227', 22:06:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:06:50 INFO - '_': '/tools/buildbot/bin/python'} 22:06:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:06:50 INFO - Downloading/unpacking blobuploader==1.2.4 22:06: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 22:06: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 22:06: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 22:06: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 22:06: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 22:06: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 22:06:52 INFO - Downloading blobuploader-1.2.4.tar.gz 22:06:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:06:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:06:52 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 22:06:52 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 22:06:52 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 22:06:52 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 22:06:52 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 22:06:52 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 22:06:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:06:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:06:52 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 22:06:52 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 22:06:52 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 22:06:52 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 22:06:52 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 22:06:52 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 22:06:53 INFO - Downloading docopt-0.6.1.tar.gz 22:06:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:06:53 INFO - Installing collected packages: blobuploader, requests, docopt 22:06:53 INFO - Running setup.py install for blobuploader 22:06:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:06:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:06:53 INFO - Running setup.py install for requests 22:06:53 INFO - Running setup.py install for docopt 22:06:53 INFO - Successfully installed blobuploader requests docopt 22:06:53 INFO - Cleaning up... 22:06:53 INFO - Return code: 0 22:06:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:06:53 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')]} 22:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:06:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06:53 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')]} 22:06:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:06:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06:53 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 0x7fa595697f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe385a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec7410>, '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 0xec8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec87a0>, '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': '82e07478c745e68b1fe4678a000001bc-1460176016.863940-1474057227', '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 22:06:53 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 22:06:53 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 22:06:53 INFO - Using env: {'DISPLAY': ':0', 22:06:53 INFO - 'HOME': '/home/cltbld', 22:06:53 INFO - 'LANG': 'en_US.UTF-8', 22:06:53 INFO - 'LANGUAGE': 'en_US:en', 22:06:53 INFO - 'LOGNAME': 'cltbld', 22:06:53 INFO - 'MAIL': '/var/mail/cltbld', 22:06:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:06:53 INFO - 'MOZ_NO_REMOTE': '1', 22:06:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:06:53 INFO - 'NO_EM_RESTART': '1', 22:06:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:06:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:06:53 INFO - 'PWD': '/builds/slave/test', 22:06:53 INFO - 'SHELL': '/bin/bash', 22:06:53 INFO - 'SHLVL': '1', 22:06:53 INFO - 'TERM': 'linux', 22:06:53 INFO - 'TMOUT': '86400', 22:06:53 INFO - 'USER': 'cltbld', 22:06:53 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1460176016.863940-1474057227', 22:06:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:06:53 INFO - '_': '/tools/buildbot/bin/python'} 22:06:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:06:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:06:53 INFO - Running setup.py (path:/tmp/pip-q_bOmY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:06:54 INFO - Running setup.py (path:/tmp/pip-bstGAR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:06:54 INFO - Running setup.py (path:/tmp/pip-5pxEmF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:06:54 INFO - Running setup.py (path:/tmp/pip-BwFEzn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:06:54 INFO - Running setup.py (path:/tmp/pip-Gk6NAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:06:54 INFO - Running setup.py (path:/tmp/pip-qMHqaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:06:54 INFO - Running setup.py (path:/tmp/pip-GgEq_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:06:54 INFO - Running setup.py (path:/tmp/pip-PvdVu4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:06:54 INFO - Running setup.py (path:/tmp/pip-dHuZNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:06:54 INFO - Running setup.py (path:/tmp/pip-F3f2E5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:06:54 INFO - Running setup.py (path:/tmp/pip-BI8roG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:06:54 INFO - Running setup.py (path:/tmp/pip-APQzSJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:06:54 INFO - Running setup.py (path:/tmp/pip-C1nDzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:06:54 INFO - Running setup.py (path:/tmp/pip-ZPew5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:06:54 INFO - Running setup.py (path:/tmp/pip-yIFBrz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:06:55 INFO - Running setup.py (path:/tmp/pip-hGhX0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:06:55 INFO - Running setup.py (path:/tmp/pip-NCzcYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:06:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:06:55 INFO - Running setup.py install for manifestparser 22:06:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:06:55 INFO - Running setup.py install for mozcrash 22:06:55 INFO - Running setup.py install for mozdebug 22:06:55 INFO - Running setup.py install for mozdevice 22:06:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:06:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:06:55 INFO - Running setup.py install for mozfile 22:06:55 INFO - Running setup.py install for mozhttpd 22:06:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:06:55 INFO - Running setup.py install for mozinfo 22:06:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:06:55 INFO - Running setup.py install for mozInstall 22:06:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:06:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:06:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:06:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:06:55 INFO - Running setup.py install for mozleak 22:06:56 INFO - Running setup.py install for mozlog 22:06:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:06:56 INFO - Running setup.py install for moznetwork 22:06:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:06:56 INFO - Running setup.py install for mozprocess 22:06:56 INFO - Running setup.py install for mozprofile 22:06:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:06:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:06:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:06:56 INFO - Running setup.py install for mozrunner 22:06:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:06:56 INFO - Running setup.py install for mozscreenshot 22:06:56 INFO - Running setup.py install for moztest 22:06:56 INFO - Running setup.py install for mozversion 22:06:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:06:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:06:56 INFO - Cleaning up... 22:06:56 INFO - Return code: 0 22:06:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:06:56 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')]} 22:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:06:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06:56 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')]} 22:06:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:06:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:06:56 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 0x7fa595697f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe385a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec7410>, '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 0xec8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec87a0>, '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': '82e07478c745e68b1fe4678a000001bc-1460176016.863940-1474057227', '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 22:06:56 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 22:06:56 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 22:06:56 INFO - Using env: {'DISPLAY': ':0', 22:06:56 INFO - 'HOME': '/home/cltbld', 22:06:56 INFO - 'LANG': 'en_US.UTF-8', 22:06:56 INFO - 'LANGUAGE': 'en_US:en', 22:06:56 INFO - 'LOGNAME': 'cltbld', 22:06:56 INFO - 'MAIL': '/var/mail/cltbld', 22:06:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:06:56 INFO - 'MOZ_NO_REMOTE': '1', 22:06:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:06:56 INFO - 'NO_EM_RESTART': '1', 22:06:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:06:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:06:56 INFO - 'PWD': '/builds/slave/test', 22:06:56 INFO - 'SHELL': '/bin/bash', 22:06:56 INFO - 'SHLVL': '1', 22:06:56 INFO - 'TERM': 'linux', 22:06:56 INFO - 'TMOUT': '86400', 22:06:56 INFO - 'USER': 'cltbld', 22:06:56 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1460176016.863940-1474057227', 22:06:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:06:56 INFO - '_': '/tools/buildbot/bin/python'} 22:06:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:06:57 INFO - Running setup.py (path:/tmp/pip-wm9drp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:06:57 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)) 22:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:06:57 INFO - Running setup.py (path:/tmp/pip-C4hsFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:06:57 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)) 22:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:06:57 INFO - Running setup.py (path:/tmp/pip-gY0XHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:06:57 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)) 22:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:06:57 INFO - Running setup.py (path:/tmp/pip-WVxrwP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:06:57 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)) 22:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:06:57 INFO - Running setup.py (path:/tmp/pip-6f_GQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:06:57 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)) 22:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:06:57 INFO - Running setup.py (path:/tmp/pip-CRXuyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:06:57 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)) 22:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:06:57 INFO - Running setup.py (path:/tmp/pip-6UGTWy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:06:57 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)) 22:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:06:57 INFO - Running setup.py (path:/tmp/pip-3wZGVE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:06:57 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)) 22:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:06:57 INFO - Running setup.py (path:/tmp/pip-8Alkkr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:06:57 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)) 22:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:06:57 INFO - Running setup.py (path:/tmp/pip-WQtaXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:06:57 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)) 22:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:06:57 INFO - Running setup.py (path:/tmp/pip-64Xaey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:06:57 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)) 22:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:06:57 INFO - Running setup.py (path:/tmp/pip-H_l21U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:06:58 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)) 22:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:06:58 INFO - Running setup.py (path:/tmp/pip-0dRgZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:06:58 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)) 22:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:06:58 INFO - Running setup.py (path:/tmp/pip-9d47R9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:06:58 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)) 22:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:06:58 INFO - Running setup.py (path:/tmp/pip-9Ttqiw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:06:58 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)) 22:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:06:58 INFO - Running setup.py (path:/tmp/pip-x9N3SY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:06:58 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)) 22:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:06:58 INFO - Running setup.py (path:/tmp/pip-SnD8rU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:06:58 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)) 22:06:58 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)) 22:06:58 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)) 22:06:58 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)) 22:06:58 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)) 22:06:58 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)) 22:06:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:06:58 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 22:06:58 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 22:06:58 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 22:06:58 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 22:06:58 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 22:06:58 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 22:07:00 INFO - Downloading blessings-1.6.tar.gz 22:07:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:07:00 INFO - Installing collected packages: blessings 22:07:00 INFO - Running setup.py install for blessings 22:07:00 INFO - Successfully installed blessings 22:07:00 INFO - Cleaning up... 22:07:00 INFO - Return code: 0 22:07:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:07:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:07:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:07:00 INFO - Reading from file tmpfile_stdout 22:07:00 INFO - Current package versions: 22:07:00 INFO - argparse == 1.2.1 22:07:00 INFO - blessings == 1.6 22:07:00 INFO - blobuploader == 1.2.4 22:07:00 INFO - docopt == 0.6.1 22:07:00 INFO - manifestparser == 1.1 22:07:00 INFO - mozInstall == 1.12 22:07:00 INFO - mozcrash == 0.17 22:07:00 INFO - mozdebug == 0.1 22:07:00 INFO - mozdevice == 0.48 22:07:00 INFO - mozfile == 1.2 22:07:00 INFO - mozhttpd == 0.7 22:07:00 INFO - mozinfo == 0.9 22:07:00 INFO - mozleak == 0.1 22:07:00 INFO - mozlog == 3.1 22:07:00 INFO - moznetwork == 0.27 22:07:00 INFO - mozprocess == 0.22 22:07:00 INFO - mozprofile == 0.28 22:07:00 INFO - mozrunner == 6.11 22:07:00 INFO - mozscreenshot == 0.1 22:07:00 INFO - mozsystemmonitor == 0.0 22:07:00 INFO - moztest == 0.7 22:07:00 INFO - mozversion == 1.4 22:07:00 INFO - psutil == 3.1.1 22:07:00 INFO - requests == 1.2.3 22:07:00 INFO - wsgiref == 0.1.2 22:07:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:07:00 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')]} 22:07:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:00 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')]} 22:07:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:00 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 0x7fa595697f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe385a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec7410>, '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 0xec8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec87a0>, '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': '82e07478c745e68b1fe4678a000001bc-1460176016.863940-1474057227', '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 22:07:00 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 22:07:00 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 22:07:00 INFO - Using env: {'DISPLAY': ':0', 22:07:00 INFO - 'HOME': '/home/cltbld', 22:07:00 INFO - 'LANG': 'en_US.UTF-8', 22:07:00 INFO - 'LANGUAGE': 'en_US:en', 22:07:00 INFO - 'LOGNAME': 'cltbld', 22:07:00 INFO - 'MAIL': '/var/mail/cltbld', 22:07:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:00 INFO - 'MOZ_NO_REMOTE': '1', 22:07:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:00 INFO - 'NO_EM_RESTART': '1', 22:07:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:07:00 INFO - 'PWD': '/builds/slave/test', 22:07:00 INFO - 'SHELL': '/bin/bash', 22:07:00 INFO - 'SHLVL': '1', 22:07:00 INFO - 'TERM': 'linux', 22:07:00 INFO - 'TMOUT': '86400', 22:07:00 INFO - 'USER': 'cltbld', 22:07:00 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1460176016.863940-1474057227', 22:07:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:00 INFO - '_': '/tools/buildbot/bin/python'} 22:07:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:00 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)) 22:07:00 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)) 22:07:00 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)) 22:07:00 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)) 22:07:00 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)) 22:07:00 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)) 22:07:00 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)) 22:07:00 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)) 22:07:00 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)) 22:07:00 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)) 22:07:00 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)) 22:07:00 INFO - Cleaning up... 22:07:00 INFO - Return code: 0 22:07:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:07:00 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')]} 22:07:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:00 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')]} 22:07:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:00 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 0x7fa595697f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe385a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec7410>, '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 0xec8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec87a0>, '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': '82e07478c745e68b1fe4678a000001bc-1460176016.863940-1474057227', '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 22:07:00 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 22:07:00 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 22:07:00 INFO - Using env: {'DISPLAY': ':0', 22:07:00 INFO - 'HOME': '/home/cltbld', 22:07:00 INFO - 'LANG': 'en_US.UTF-8', 22:07:00 INFO - 'LANGUAGE': 'en_US:en', 22:07:00 INFO - 'LOGNAME': 'cltbld', 22:07:00 INFO - 'MAIL': '/var/mail/cltbld', 22:07:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:00 INFO - 'MOZ_NO_REMOTE': '1', 22:07:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:00 INFO - 'NO_EM_RESTART': '1', 22:07:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:07:00 INFO - 'PWD': '/builds/slave/test', 22:07:00 INFO - 'SHELL': '/bin/bash', 22:07:00 INFO - 'SHLVL': '1', 22:07:00 INFO - 'TERM': 'linux', 22:07:00 INFO - 'TMOUT': '86400', 22:07:00 INFO - 'USER': 'cltbld', 22:07:00 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1460176016.863940-1474057227', 22:07:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:00 INFO - '_': '/tools/buildbot/bin/python'} 22:07:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:01 INFO - Downloading/unpacking jsonschema 22:07:01 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 22:07:01 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 22:07:01 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 22:07:01 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 22:07:01 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 22:07:01 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 22:07:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:07:03 INFO - Downloading/unpacking functools32 (from jsonschema) 22:07:03 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 22:07:03 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 22:07:03 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 22:07:03 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 22:07:03 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 22:07:03 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 22:07:03 INFO - Downloading functools32-3.2.3-2.tar.gz 22:07:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:07:03 INFO - warning: no files found matching '*.txt' 22:07:03 INFO - no previously-included directories found matching 'build' 22:07:03 INFO - no previously-included directories found matching 'dist' 22:07:03 INFO - no previously-included directories found matching '.git*' 22:07:03 INFO - Installing collected packages: jsonschema, functools32 22:07:03 INFO - Running setup.py install for functools32 22:07:03 INFO - warning: no files found matching '*.txt' 22:07:03 INFO - no previously-included directories found matching 'build' 22:07:03 INFO - no previously-included directories found matching 'dist' 22:07:03 INFO - no previously-included directories found matching '.git*' 22:07:03 INFO - Successfully installed jsonschema functools32 22:07:03 INFO - Cleaning up... 22:07:03 INFO - Return code: 0 22:07:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:07:03 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')]} 22:07:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:03 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')]} 22:07:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:03 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 0x7fa595697f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe385a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec7410>, '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 0xec8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec87a0>, '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': '82e07478c745e68b1fe4678a000001bc-1460176016.863940-1474057227', '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 22:07:03 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 22:07:03 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 22:07:03 INFO - Using env: {'DISPLAY': ':0', 22:07:03 INFO - 'HOME': '/home/cltbld', 22:07:03 INFO - 'LANG': 'en_US.UTF-8', 22:07:03 INFO - 'LANGUAGE': 'en_US:en', 22:07:03 INFO - 'LOGNAME': 'cltbld', 22:07:03 INFO - 'MAIL': '/var/mail/cltbld', 22:07:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:03 INFO - 'MOZ_NO_REMOTE': '1', 22:07:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:03 INFO - 'NO_EM_RESTART': '1', 22:07:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:07:03 INFO - 'PWD': '/builds/slave/test', 22:07:03 INFO - 'SHELL': '/bin/bash', 22:07:03 INFO - 'SHLVL': '1', 22:07:03 INFO - 'TERM': 'linux', 22:07:03 INFO - 'TMOUT': '86400', 22:07:03 INFO - 'USER': 'cltbld', 22:07:03 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1460176016.863940-1474057227', 22:07:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:03 INFO - '_': '/tools/buildbot/bin/python'} 22:07:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:03 INFO - Downloading/unpacking flake8 22:07:03 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 22:07:03 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 22:07:03 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 22:07:03 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 22:07:03 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 22:07:03 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 22:07:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:07:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:07:05 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 22:07:05 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 22:07:05 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 22:07:05 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 22:07:05 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 22:07:05 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 22:07:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:07:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:07:05 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 22:07:05 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 22:07:05 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 22:07:05 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 22:07:05 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 22:07:05 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 22:07:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:07:05 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 22:07:05 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 22:07:05 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 22:07:05 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 22:07:05 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 22:07:05 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 22:07:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:07:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:07:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:07:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:07:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:07:06 INFO - no previously-included directories found matching 'docs/_build' 22:07:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:07:06 INFO - Running setup.py install for pep8 22:07:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:07:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:07:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:07:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:07:06 INFO - no previously-included directories found matching 'docs/_build' 22:07:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:07:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:07:06 INFO - Cleaning up... 22:07:06 INFO - Return code: 0 22:07:06 INFO - Running post-action listener: _resource_record_post_action 22:07:06 INFO - Running post-action listener: _start_resource_monitoring 22:07:06 INFO - Starting resource monitoring. 22:07:06 INFO - ##### 22:07:06 INFO - ##### Running install step. 22:07:06 INFO - ##### 22:07:06 INFO - Running pre-action listener: _resource_record_pre_action 22:07:06 INFO - Running main action method: install 22:07:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:07:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:07:06 INFO - Reading from file tmpfile_stdout 22:07:06 INFO - Detecting whether we're running mozinstall >=1.0... 22:07:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:07:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:07:06 INFO - Reading from file tmpfile_stdout 22:07:06 INFO - Output received: 22:07:06 INFO - Usage: mozinstall [options] installer 22:07:06 INFO - Options: 22:07:06 INFO - -h, --help show this help message and exit 22:07:06 INFO - -d DEST, --destination=DEST 22:07:06 INFO - Directory to install application into. [default: 22:07:06 INFO - "/builds/slave/test"] 22:07:06 INFO - --app=APP Application being installed. [default: firefox] 22:07:06 INFO - mkdir: /builds/slave/test/build/application 22:07:06 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'] 22:07:06 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 22:07:22 INFO - Reading from file tmpfile_stdout 22:07:22 INFO - Output received: 22:07:22 INFO - /builds/slave/test/build/application/firefox/firefox 22:07:22 INFO - Running post-action listener: _resource_record_post_action 22:07:22 INFO - ##### 22:07:22 INFO - ##### Running run-tests step. 22:07:22 INFO - ##### 22:07:22 INFO - Running pre-action listener: _resource_record_pre_action 22:07:22 INFO - Running main action method: run_tests 22:07:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:07:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:07:22 INFO - Python 2.7.3 22:07:22 INFO - Return code: 0 22:07:22 INFO - grabbing minidump binary from tooltool 22:07:22 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')]} 22:07:22 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 0xec7410>, '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 0xec8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec87a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:07:22 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 22:07:22 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 22:07:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:07:22 INFO - Return code: 0 22:07:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:07:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:07:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:07:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:07:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:07:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:07:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:07:23 INFO - Return code: 0 22:07:23 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 22:07:23 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 22:07:23 INFO - Using env: {'DISPLAY': ':0', 22:07:23 INFO - 'HOME': '/home/cltbld', 22:07:23 INFO - 'LANG': 'en_US.UTF-8', 22:07:23 INFO - 'LANGUAGE': 'en_US:en', 22:07:23 INFO - 'LOGNAME': 'cltbld', 22:07:23 INFO - 'MAIL': '/var/mail/cltbld', 22:07:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:07:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:07:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:23 INFO - 'MOZ_NO_REMOTE': '1', 22:07:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:07:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:23 INFO - 'NO_EM_RESTART': '1', 22:07:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:07:23 INFO - 'PWD': '/builds/slave/test', 22:07:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:07:23 INFO - 'SHELL': '/bin/bash', 22:07:23 INFO - 'SHLVL': '1', 22:07:23 INFO - 'TERM': 'linux', 22:07:23 INFO - 'TMOUT': '86400', 22:07:23 INFO - 'USER': 'cltbld', 22:07:23 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1460176016.863940-1474057227', 22:07:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:23 INFO - '_': '/tools/buildbot/bin/python'} 22:07:23 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 22:07:23 INFO - mozversion application_buildid: 20160408213953 22:07:23 INFO - mozversion application_changeset: ca3f8c085a584d804511d9a551e95606fc8ff41d 22:07:23 INFO - mozversion application_display_name: Nightly 22:07:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:07:23 INFO - mozversion application_name: Firefox 22:07:23 INFO - mozversion application_remotingname: firefox 22:07:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:07:23 INFO - mozversion application_vendor: Mozilla 22:07:23 INFO - mozversion application_version: 48.0a1 22:07:23 INFO - mozversion platform_buildid: 20160408213953 22:07:23 INFO - mozversion platform_changeset: ca3f8c085a584d804511d9a551e95606fc8ff41d 22:07:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:07:23 INFO - mozversion platform_version: 48.0a1 22:07:23 INFO - using testdate: 1460178443 22:07:23 INFO - actual date: 1460178443 22:07:23 INFO - starting webserver on 'localhost:39795' 22:07:23 INFO - SUITE-START | Running 2 tests 22:07:23 INFO - TEST-START | dromaeo_css 22:07:23 INFO - operating with platform_type : linux_ 22:07:23 INFO - Initialising browser for dromaeo_css test... 22:07:23 INFO - TEST-INFO | started process 2625 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ69viJ/profile http://localhost:39795/getInfo.html) 22:07:28 INFO - PROCESS | 2625 | __metrics Screen width/height:1600/1200 22:07:28 INFO - PROCESS | 2625 | colorDepth:24 22:07:28 INFO - PROCESS | 2625 | Browser inner width/height: 1024/697 22:07:28 INFO - PROCESS | 2625 | __metrics 22:07:29 ERROR - PROCESS | 2625 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:07:30 INFO - TEST-INFO | 2625: exit 0 22:07:30 INFO - Browser initialized. 22:07:30 INFO - Running cycle 1/1 for dromaeo_css test... 22:07:30 INFO - TEST-INFO | started process 2765 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ69viJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:07:42 INFO - PROCESS | 2765 | RSS: Main: 153894912 22:07:42 INFO - PROCESS | 2765 | 22:08:33 INFO - PROCESS | 2765 | 1460178513103 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] 22:10:44 INFO - PROCESS | 2765 | Cycle 1(1): loaded http://localhost:39795/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39795/tests/dromaeo/cssquery-ext.html) 22:10:45 INFO - PROCESS | 2765 | RSS: Main: 260616192 22:10:45 INFO - PROCESS | 2765 | 22:13:47 INFO - PROCESS | 2765 | Cycle 1(1): loaded http://localhost:39795/tests/dromaeo/cssquery-ext.html (next: http://localhost:39795/tests/dromaeo/cssquery-jquery.html) 22:13:48 INFO - PROCESS | 2765 | RSS: Main: 233709568 22:13:48 INFO - PROCESS | 2765 | 22:16:50 INFO - PROCESS | 2765 | Cycle 1(1): loaded http://localhost:39795/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39795/tests/dromaeo/cssquery-mootools.html) 22:16:51 INFO - PROCESS | 2765 | RSS: Main: 237236224 22:16:51 INFO - PROCESS | 2765 | 22:19:53 INFO - PROCESS | 2765 | Cycle 1(1): loaded http://localhost:39795/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39795/tests/dromaeo/cssquery-prototype.html) 22:19:53 INFO - PROCESS | 2765 | RSS: Main: 215597056 22:19:53 INFO - PROCESS | 2765 | 22:22:56 INFO - PROCESS | 2765 | Cycle 1(1): loaded http://localhost:39795/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39795/tests/dromaeo/cssquery-yui.html) 22:22:57 INFO - PROCESS | 2765 | RSS: Main: 210640896 22:22:57 INFO - PROCESS | 2765 | 22:26:00 INFO - PROCESS | 2765 | Cycle 1(1): loaded http://localhost:39795/tests/dromaeo/cssquery-yui.html (next: http://localhost:39795/tests/dromaeo/cssquery-dojo.html) 22:26:00 INFO - PROCESS | 2765 | RSS: Main: 267309056 22:26:00 INFO - PROCESS | 2765 | 22:26:00 INFO - PROCESS | 2765 | __start_tp_report 22:26:00 INFO - PROCESS | 2765 | _x_x_mozilla_page_load 22:26:00 INFO - PROCESS | 2765 | _x_x_mozilla_page_load_details 22:26:00 INFO - PROCESS | 2765 | |i|pagename|runs| 22:26:00 INFO - PROCESS | 2765 | |0;dojo.html;2609.3476630842288;2613.085420102963;2624.6981597116337;2636.657234559507;2653.65502484677;4475.172093162759;4553.635709143269;4637.744924029177;4660;4666.48668646449;4597.88505287368;4637.536246375361;4694.953050469494;4712.3638308828295;4719.174144524712;4179.853705120321;4215.957840421603;4236.872893813191;4277.25148099083;4284.164587905359;4232.830686772525;4287.957120428802;4349;4378.62781663559;4389.692721509496;4139.855105071339;4312;4337.761423121727;4348.543402942693;4350.216960947028;4173.436586060873;4179.770112643803;4241.045764702948;4313.331433627762;4339.0237196630505;4255.1064276501975;4257.510386305553;4264.296391095466;4267.4025636410925;4306.44016277885;4554.362389265505;4556.498785133633;4580.083983203339;4582.725036497787;4593.425821772278;4822.397200349957;4986.152354099811;5027.924581131286;5062.139436295838;5077.593792496591;5032;5040.092783299005;5059.266406371093;5063.240513922904;5064.5441910228255;4532.0482698632995;4720.551547602938;4724.574788269072;4727.834525791581;4759.619230461555;5135.4094279157625;5164.612654050961;5184.766685499161;5213.983273261678;5241.895162096736;4887;4897.559219670246;4898.485659005824;4902.779374928136;4944.208926571731;4796.448408433005;4958.181899986534;4978.8755281118265;4980.352554167935;5016.899662006739;4870.245112007645;4881.682690625098;4895.167821470359;4924.8768780780765;4937.21004639256;4890.902181956341;4898.02039592083;4900.166971614834;4901.43633482147;4949.480304567968;4213.494380674339;4273.252180868398;4288.335308027261;4292.5492823253735;4325.199838029975;3684;3706.240220754739;3741.064733816546;3743.2139250757646;3764.6800021997888;4293.935590966138;4296.613304802583;4301.978490107529;4314.56854314566;4346.434963454731;4813.133635945564;4946.159152944008;4954.578860796801;4956.3804524434445;5022.070916880389;4273.465816772903;4303.591158839905;4308.892277693083;4333.739975601474;4337.7397356158735;4528.547145285445;4530.909381812411;4547.909041819145;4557.088582283556;4584.977075114603;4547.727136371828;4673.135469938073;4752.19212733843;4765.523447655207;4766.45185803637;4911.828086017115;4929.630277729257;4936.3829521309835;4983.202687569971;4983.277424773315;4660.300954856799;4683.672142949961;4691.085238378483;4696.506866778939;4724.692894961817;4736.644751643572;4866.172750632471;4923.286123512143;4955.132851751001;5019.297298378157;5019.372578427697;5021.72380519075;5022.598192144546;5033.697978121324;5051.570616497639;4860.805567777249;4867.41591009067;4873.171560834738;4874.58566021878;4904.215325547895;4637.46669133054;4758.738269395217;4828.517148285144;4856.757162141808;4900.828471003498;4719;4735.218688916428;4742.2175341069715;4743.976280118577;4795.856124316276;4842.927356089732;4844.079624871263;4850.490698476609;4851.393575803025;4856.732879691651;4582.358469814162;4690.695104818176;4719.716816990992;4751.144793936986;4778.808847646194 22:26:00 INFO - PROCESS | 2765 | |1;ext.html;566.4081035318095;591.5267785771382;592.632567807959;611.2084850119094;618.0327787013326;34096.31807363854;35311.11722206949;35339.82330088352;35494.822525887364;35502.644973550254;37869.86390408292;38557.61442385575;38681.80659096708;38802.22395552087;38853.94898663177;7629.771106866789;7802.960985195066;7821.960890195541;7826.491278066936;7827.217278272155;7651.502652327608;7743.8838417423785;7767.728129515468;7933.484323518982;7934.761957141295;7906.248906353887;8020.558869262218;8024.037115546143;8026.157253488387;8028.438009339348;7891.644875980594;7935.72224972129;7956.6817327306835;7957.6021198939825;7957.840843183133;7863.095743989457;7955;7970.362371010306;7972.3622110231045;7976.7208147714555;37442.81278593617;37747.62252377496;37847.24305513902;37851.62148378536;37897.24205515902;2953.7636989040825;3102.115896969353;3106.1613364391487;3338.282269312085;3346.983265083659;28722;28940.8552957236;28990.130296091153;29574.704252957625;29779.851100744574;3422.5379573757723;3484.703800176988;3487.110786749388;3523.3481805865995;3545.592256890465;178192;178269;178493.1075344628;178545;179076;51219.48780512222;51306.74346628243;51354;51371.22943155855;51400.22899656508;58412.70793646004;60178.398216018155;60250;60260.56352110708;60419.09371359433;15488.07071575709;15878.44425445127;15928.283227254802;15930.840691593168;15931.283092260875;10184.745381365525;10251.692449226535;10260.948695256477;10266.281360304856;10266.743331416774;18562.535936601693;18614;18674.253029878924;18690.34583789561;18749.906250468932;6720.6639668016405;6857.245702972669;6919.827004324932;7008.7546935857;7041.5422997505;849.4351256414416;907.9785241603197;909.5952301225891;920.3097676742443;978.2516374973151;26741.866290668422;27965.860170699423;28434.573481397794;28505.429891402055;28506;972.5040229483014;980.8038392321564;1005.215931573374;1049.6903413493037;1074.8292537015834;14252;14786.890983176305;14866.554003379915;14884.479043233436;15137.318820653098;341166;347251;347916;348257;350460;48058.519414806105;48827.75586122047;49008.50991490111;49050.75474622604;49119.50880491149;1104.7127746785893;1189.4766302826729;1217.6103646833105;1233.6237447578574;1258.5972488803677;26599.867000665647;27286.317842054108;27353;28181.57727634046;28219.43561128807;37831.243375131795;38258.80870595629;38476.2304753909;38536.42195367016;38644;223764;223772;224090;225100;225574;24851.502969940862;26045.869770651025;26052.478950420507;26057.348566285993;26071.217863464128;41115.1776964465;41156.58843411647;41397;41979;42446;34303.82848085744;35246;35491.11272218215;35578.28843423065;36041.63958360383;34376;34741.65258347384;35013.47479787754;35218.82390588031;35330.823345884135;35298.11754706153;35596.466053008706;35944.281114377045;36352.63647363493;36703.63296367109;30959.535606966365;31528.684713152576;31686.366272674877;31797.364052718352;31851;24577.877110614332;25298.74701252964;25348.366290842878;25663.358416039748;25672.229833105037 22:26:00 INFO - PROCESS | 2765 | |2;jquery.html;361.20174414543857;367.28562945071843;368.97232707546937;382.49892640640763;384.3331819293527;15758.527244182664;16453.424130155447;17005.234764435616;17014.149292535356;17064.317427302925;15755.763663545027;16313.347466101372;16877.15614219287;16953.745693814602;16978.49064528063;4972.776225069881;5107.233914912774;5135.152699804527;5150.3047088642925;5155.74221288934;3711.8329675164546;3915.725899187058;5064.2403639454005;5377.11277639189;5725.255716756837;5647.858803529924;5680.460356266148;5710.400407957167;5715.685637289947;5716.7141642917895;5596.468335508141;5655.293088363975;5712.171735098429;5828.242328497311;5842.737076831553;3328.251143492719;4757.215059515176;5100.030994111107;5113.284140220372;5127.589792816566;18745.9062704687;19379.709304360447;19503.512412189666;19678.90160549188;19693.409197723948;1869.140195510067;1933.2460340467228;1942.3784388995527;2033.7864524224892;2047.6518991771434;12530.937345313216;12586.37068146589;12626.24242545441;12907.290099044549;13093.214407135602;1717.252994947202;1754.754334393186;1767.0419895583943;1770.6989811732037;1790.9552261193444;62473;63035.36964630341;63151.68424157896;63988.680056599886;64278.71442571169;9384.5307734613;9451.763705907408;9813.705588832347;10235;10411.271211015157;13658.112222705691;13716.382762775698;13722.862771372358;13723.931380343034;13750.793738093937;7811;7848.960755196187;7863.685452581947;7867;8019.43863929531;7646.3882889368715;7659.808504787314;7763.301302882767;7796.181400952932;7799.844003119906;6129;6190.721417536221;6227.314995350508;6249.6875156242;6375.23497180332;1543.1127101916443;1676.1954261954331;1677.3206851225273;1681.2266357475698;1710.9905155958045;834.1866679987086;898.5911410308294;908.1780988205685;909.3134683314056;935.9438433694;16391.09848958295;17225.569360765832;18280.45158645243;18482.445526634223;18847.24611015544;838.1534650003418;849.9830003400021;870.5299138465158;877.2674816528271;902.6840605787921;8566.528840913685;8575.914240857512;8678.262347700389;8726.432781869158;8756.8686469703;405178;408499;410222.92659270944;410284;421874;78232.60883695545;78631;80676.59661701653;80726;81292.18707812847;883.4919921045424;959.6928982725461;998.8701468809008;1011.9392836429838;1021.402479549457;14369.56891293263;14429.711405772036;14508.637284067983;14523.128612283297;15031.699366012837;30615.846920765252;30653.23366915845;31042.379152417278;31090;31826.204344891565;43770.34344484771;44020.33969490396;44452;44520.77739611411;44923.32615010712;6800.93199068003;7114.430845532448;7174;7274.781756547312;7320.707171713072;10506.527206275583;11443.885561144281;11542.942285288857;11712.941435292769;11732.88267117352;9746.463944483121;9832.31173817826;9954.153896918842;10014.19886409071;10097.747556311151;9857.457839818879;10001.199904007517;10050.296479246383;10127.594896204364;10198;10100.343477673927;10116;10436.112930401001;10447.216458765472;10590.523426445674;7335.669894854851;7378.225286344857;7404.740834070782;7474.140473845578;7819.257170568787;10173.186145108522;10371.896281037394;10421.583136674448;10423.11403530678;10466.424346661006 22:26:00 INFO - PROCESS | 2765 | |3;mootools.html;1276.9170003949748;1382.4884792626726;1421.4882642248788;1548.4967385599682;1802.4322338463382;6586.835329116774;7635.961820190898;7837.843243135134;7851.685932562691;7859.842803143941;7611.733589324361;7782.221777822215;7790.727324543642;7792.571408572526;7801.765947021584;1874.4189301316567;2166.685830554569;2205.095910676619;2236.2732112063563;2251.189571754167;2260.1976298414074;2280.304507125326;2281.566502364554;2283.954320913581;2285.7942785149335;2218.9001494932686;2261.6381378979368;2262.46831994482;2263.219189379661;2264.116994372196;2185.9344219673435;2194.297824696098;2195.6057903231485;2197.1760589778833;2213.0815711479718;2128.287023847013;2141.453929248047;2145.7639659637425;2148.151480165326;2151.397608669575;7859.449838511307;7971.163027882105;7981.281684648409;7990.960045199737;8005.599720013976;4527.615152712024;4656.580907718288;4673.018666080094;4678.391809064799;4680.455449701591;2902.941941161165;2934.207763903734;3002.8348440835744;3024.138120635608;3025.667176610571;972.8054389122133;1699.2268517824484;1714.2285971312958;1733.8092809790912;1767.5846176148596;10291.02235287654;10400.323978941344;10433.843492347622;10438.79122417555;10446.63436779709;3920.5491368492417;3986.7807270599815;4134.524529679125;4147.709660323749;4173.707840451139;8558.700445484377;8574.314054875595;8602.612882420306;8608.569571521399;8611.181937715906;4062.6343629073526;4602.194615942197;4602.217623004098;4603.309503574424;4612.123696497655;3863.613638636114;3867.0719027433215;3871.728978971445;3879.6120387960977;4212.199682060399;3457.4640930655787;3529.2412131391875;3594.370985077601;3596.813051692935;3597.460380942827;1098.4727330881221;1102.2339474065607;1110.8444817725524;1112.232559533919;1117.251441534174;995.581855620641;1007.9798404031878;1012.9819531370925;1099.301943266032;1261.8611952685196;7329.963350183321;7412.592307423036;7533.886991695129;7553.622318884144;7572.697092116364;436.3171636389041;437.80955284451363;438.5461047815559;438.8025388575154;443.86683994802075;5765.509931655856;5896.086106653475;5950.047992321294;5958.374370691015;5961.225040744762;9299;9370.437773733598;9665.130138287588;9713.90286097144;9842.212622990144;9665.130138287588;9772.609095636095;9801.11789938909;9876.308658393844;9901.108900199017;7219.819504512324;7562.924370756332;7576.3181313682035;7580.772576822704;7598.848023039508;7200.71197152108;7289.4168466523615;7324.267573242633;7395.963020184865;7402.259774022555;9075.410098343851;9090.090990900857;9179.403338783224;9251.074892510964;9340.206082482793;8959.462432254086;9087.545622718706;9230.584623691815;9306.72079837606;9317.39436936597;5667.2349232854685;6054.75780968774;6203.06953956892;6517;6618.602883826986;7341;7353.080864891888;7382.852342953218;7401.33387995083;7406.555606663617;6616;6658.966705166443;6749.9662501689145;6875.037494750639;6917.481188910751;6569.343065693583;6626.0392243123515;6675;6682.131322927989;6778.525503214728;6881.10545629065;6930.584164949917;6956.478264130109;6970.198427180939;6981.441484681111;6567.737290508326;6639.402453779183;6642.933570664231;6649.63427011519;6656.73373065072;6510.641914694737;6558.213014438298;6586.5389422739945;6588.8023359299295;6604.174478190226 22:26:00 INFO - PROCESS | 2765 | |4;prototype.html;312.48752046643494;316.5773692121018;320.51762098042445;320.66650683289396;321.9323941972185;4936.925946110807;5126.794928202877;5148.3564554430695;5167.534921857032;5171.0692075426405;5049.166887463564;5072.13773658478;5102.260172275018;5102.754787893325;5106.106431374513;3680.2271522980204;3807.4288856671583;3829.7127715421316;3947.8748556661358;3953.644172024517;3925.4504369388164;3936.4488971544006;3938.2714197873483;3943.2113577284513;3954.62431069048;3910.1397692507603;3910.6284902934317;3921.4902062731803;3923.431102490137;3927.7446965947265;3668.413053911375;3755.324041672498;3936.350502167139;3939.7589759225752;3943.4676318696897;3428.9657103429145;3443.5867695876655;3444.9311013779834;3446.638102999174;3449.1721986723255;4808.61531077513;4819.1325561398935;4845.70925744453;4853.684510506841;4857.951420485785;4265.786710664485;4458.910821783578;4490.461144662629;4512.345709872083;4513.210188217049;5279.208118782213;5281.524662780368;5284.260203571503;5310.62825602208;5350.892982140335;3775.263823554408;3781.4138808484727;3781.6785573226307;3782.0544863784053;3787.810609469543;5458.590605704588;5478;5529.313559364433;5533.114701647757;5603.215549823028;3811.313963486544;3820.0899550224885;3844.38489841624;3848.3842585186235;3858.2476417098396;3886.3004659161056;3898.4737060497037;3902.1415288636454;3903.6877049835944;3905.3165696003084;4433.1577000369825;4437;4486.573775491323;4493;4501.437320334958;5064.139096353629;5322.0154271459905;5336.466353364633;5395.757190926418;5410.296661433988;1324.6291038509232;1344.7713888638955;1352.2022007015908;1354.613935028512;1361.7821148616174;854.3677678517852;883.7481317824389;915.190056799737;930.2325581395376;934.1825902335456;4381.649468042613;4616.261398176276;4632.2356811126465;4729.527047295312;4809.9038019240115;5532.861678458071;5549.112142057252;5561.470595586246;5565.248691426606;5568.273835111128;4652.092841895866;4760.2625041860165;4770.308305295782;4777.331173635694;4790.952090479051;2932.003118939571;2946.6316710411197;2953.881844726187;2954.926126846846;2956.2461572298926;5242;5244.685318880879;5258.947410525922;5260.237265596467;5273.367195936436;5532.004239236895;5646.943530564642;5647.519960803378;5651.406602306781;5651.547876169897;5199.818006369759;5216.347956505437;5221.582273418194;5249.133892907627;5251.6323857331145;5497.560195184456;5508.834734957958;5512.173174023928;5513.724313784375;5539.362973258127;5165.819196328111;5471.671699698031;5474.233607295061;5480.123180291134;5487.725613719378;5247.396549396868;5275.657082289639;5278.1027225372545;5284.867878302919;5306.257124002565;3838.1556057667267;3855.1133239355668;3859.1702783901596;3860.285847118292;3865.8646947356706;5245.423003469692;5554.861128471659;5555.2222688822785;5556.16657501378;5565.415631358649;5352.9464705354;5362.142057270974;5365.490278423544;5383.784648614168;5403.13549832025;5181.455947125498;5364;5364.9731751341;5376.489233522809;5397.163439666858;5256.868578285574;5280.234366016983;5287.4930644766055;5297.947020529746;5303.337082864642;5073.289739436408;5154.587632989277;5317.335333083364;5344.706041167773;5352.41123476425;5213.348331458567;5238.397584277857;5254.842354729364;5258.291055406931;5268.841934741964 22:26:00 INFO - PROCESS | 2765 | |5;yui.html;607.3528461588162;623.3890787028712;636.0332294911734;647.4690753582062;672.754444627711;11987.880121198785;12664.303463309527;12735.872641273585;12919.354032298394;12971.221726696405;12567.874321256784;12606.558770443036;12659.240445573249;12686.048546359038;12692.619221423349;658.9077529145924;787.5904529644581;819.9590020498981;826.0789220019665;826.7602395305354;824.7608193623842;830.8296799156188;830.8670612701969;831.1480732249432;831.418007394823;838.932885369172;843.6077224090797;843.6920524008754;843.9198276163754;844.6410275632862;681.6216999565264;827.8509868223717;830.3896635972555;833.6582001379436;857.9399442038997;628.6699482771581;628.8585068359628;629.0344321466526;629.2260519560965;629.6379581740472;12879.03407244451;12950.805737913939;12965.35173241334;12968.935155324163;12973.41619627119;11846.822297665542;12172.391380430943;12408.62774116778;12445.315507647076;12531.812022819666;9840.11555511283;9855.753606159904;9868.161206297473;9941.453220072894;10072.697819065366;3291.4600223720213;3302.884399046022;3334.866605335784;3381.492776083607;3381.847816848223;43906.34140487895;43998.340024899655;44131.55868441307;44447;45149.322760158626;9488.762780930532;9488.765519529808;9554.127434862668;9726.659566915265;9742.853857192147;17834.286628534974;17865.553361166076;18113.54716132081;18122.184501697455;18143.455696329132;5898.203742494794;6030.216071910623;6136.355682653257;6219.222597175353;6312.589681670768;3637.2361804021452;3783.6783873370523;3803.8478460861256;3822.6750726188584;3880.8835734927998;2745.752882240608;2819.9295017624313;2823.1107201231957;2827.23664610554;2827.3214428537412;474.6511314184072;478.0987837925466;485.7862540482247;493.7481884239064;516.5867306155061;531.2774626507946;595.1548800702925;596.5347029317139;608.9543284253699;615.6829232945037;7666.3866890648615;7675.270849269311;7754.108277548155;7814.335781458526;7816.41376896735;508.0347340053927;530.8115618955293;577.2870504926412;578.9565782566324;590.9704514774244;3766.453864189677;3849.1531862990096;3899.9610003900166;3940.0937784309767;3967.6429121379215;54245.45754542404;57220.42779572151;57401.42598573961;57623.71188144032;57636.423635763946;36995.815020924725;39877.80061099676;40009.79995100064;41980.16039679189;49199.50800492021;38108.04729881775;38491;38995.805020974716;39316.41025384564;39696.20607587832;7688.884666730115;7962.840743184988;8000.759977200693;8053.557054361832;8242.381821363542;25983.740162598133;26250.343741406617;26629.067982620516;26948.730512694623;27737.306567335978;35092.298154037286;36539.817300913324;36620.81689591535;36742;36955.6304436963;9865.45739984279;10037.44794036335;10103.848442273225;10232.744181395226;10261.58953641846;11444.599439019594;11661.950424461838;11768.117391195523;11853.863022690028;11865.644030679094;10834.566617335218;11080.833787493355;11286.66140015801;11317.71705707364;11618.6514404568;10964.725881852699;11059.502322395672;11499.195056345976;11547.614286285363;11842.230255033395;10883.401412922365;11174.832377514507;11504.36725980079;11536.192466527262;11563.19057665989;9318.201126420036;9520.95389443596;9530.761730956781;9753.707388778348;9922.503874806374;9238.30712696564;9264.212541934012;9336.346455748033;9612.903870961201;9665.178459830993 22:26:00 INFO - PROCESS | 2765 | __end_tp_report 22:26:00 INFO - PROCESS | 2765 | __start_cc_report 22:26:00 INFO - PROCESS | 2765 | _x_x_mozilla_cycle_collect,999 22:26:00 INFO - PROCESS | 2765 | __end_cc_report 22:26:00 INFO - PROCESS | 2765 | __startTimestamp1460179560324__endTimestamp 22:26:00 INFO - PROCESS | 2765 | 22:26:00 INFO - PROCESS | 2765 | ------- Summary: start ------- 22:26:00 INFO - PROCESS | 2765 | Number of tests: 6 22:26:00 INFO - PROCESS | 2765 | 22:26:00 INFO - PROCESS | 2765 | [#0] dojo.html Cycles:165 Average:4600.21 Median:4720.55 stddev:474.98 (10.1%) stddev-sans-first:450.02 22:26:00 INFO - PROCESS | 2765 | Values: 2609.3 2613.1 2624.7 2636.7 2653.7 4475.2 4553.6 4637.7 4660.0 4666.5 4597.9 4637.5 4695.0 4712.4 4719.2 4179.9 4216.0 4236.9 4277.3 4284.2 4232.8 4288.0 4349.0 4378.6 4389.7 4139.9 4312.0 4337.8 4348.5 4350.2 4173.4 4179.8 4241.0 4313.3 4339.0 4255.1 4257.5 4264.3 4267.4 4306.4 4554.4 4556.5 4580.1 4582.7 4593.4 4822.4 4986.2 5027.9 5062.1 5077.6 5032.0 5040.1 5059.3 5063.2 5064.5 4532.0 4720.6 4724.6 4727.8 4759.6 5135.4 5164.6 5184.8 5214.0 5241.9 4887.0 4897.6 4898.5 4902.8 4944.2 4796.4 4958.2 4978.9 4980.4 5016.9 4870.2 4881.7 4895.2 4924.9 4937.2 4890.9 4898.0 4900.2 4901.4 4949.5 4213.5 4273.3 4288.3 4292.5 4325.2 3684.0 3706.2 3741.1 3743.2 3764.7 4293.9 4296.6 4302.0 4314.6 4346.4 4813.1 4946.2 4954.6 4956.4 5022.1 4273.5 4303.6 4308.9 4333.7 4337.7 4528.5 4530.9 4547.9 4557.1 4585.0 4547.7 4673.1 4752.2 4765.5 4766.5 4911.8 4929.6 4936.4 4983.2 4983.3 4660.3 4683.7 4691.1 4696.5 4724.7 4736.6 4866.2 4923.3 4955.1 5019.3 5019.4 5021.7 5022.6 5033.7 5051.6 4860.8 4867.4 4873.2 4874.6 4904.2 4637.5 4758.7 4828.5 4856.8 4900.8 4719.0 4735.2 4742.2 4744.0 4795.9 4842.9 4844.1 4850.5 4851.4 4856.7 4582.4 4690.7 4719.7 4751.1 4778.8 22:26:00 INFO - PROCESS | 2765 | 22:26:00 INFO - PROCESS | 2765 | [#1] ext.html Cycles:180 Average:41429.33 Median:35320.97 stddev:68221.03 (193.1%) stddev-sans-first:68343.42 22:26:00 INFO - PROCESS | 2765 | Values: 566.4 591.5 592.6 611.2 618.0 34096.3 35311.1 35339.8 35494.8 35502.6 37869.9 38557.6 38681.8 38802.2 38853.9 7629.8 7803.0 7822.0 7826.5 7827.2 7651.5 7743.9 7767.7 7933.5 7934.8 7906.2 8020.6 8024.0 8026.2 8028.4 7891.6 7935.7 7956.7 7957.6 7957.8 7863.1 7955.0 7970.4 7972.4 7976.7 37442.8 37747.6 37847.2 37851.6 37897.2 2953.8 3102.1 3106.2 3338.3 3347.0 28722.0 28940.9 28990.1 29574.7 29779.9 3422.5 3484.7 3487.1 3523.3 3545.6 178192.0 178269.0 178493.1 178545.0 179076.0 51219.5 51306.7 51354.0 51371.2 51400.2 58412.7 60178.4 60250.0 60260.6 60419.1 15488.1 15878.4 15928.3 15930.8 15931.3 10184.7 10251.7 10260.9 10266.3 10266.7 18562.5 18614.0 18674.3 18690.3 18749.9 6720.7 6857.2 6919.8 7008.8 7041.5 849.4 908.0 909.6 920.3 978.3 26741.9 27965.9 28434.6 28505.4 28506.0 972.5 980.8 1005.2 1049.7 1074.8 14252.0 14786.9 14866.6 14884.5 15137.3 341166.0 347251.0 347916.0 348257.0 350460.0 48058.5 48827.8 49008.5 49050.8 49119.5 1104.7 1189.5 1217.6 1233.6 1258.6 26599.9 27286.3 27353.0 28181.6 28219.4 37831.2 38258.8 38476.2 38536.4 38644.0 223764.0 223772.0 224090.0 225100.0 225574.0 24851.5 26045.9 26052.5 26057.3 26071.2 41115.2 41156.6 41397.0 41979.0 42446.0 34303.8 35246.0 35491.1 35578.3 36041.6 34376.0 34741.7 35013.5 35218.8 35330.8 35298.1 35596.5 35944.3 36352.6 36703.6 30959.5 31528.7 31686.4 31797.4 31851.0 24577.9 25298.7 25348.4 25663.4 25672.2 22:26:00 INFO - PROCESS | 2765 | 22:26:00 INFO - PROCESS | 2765 | [#2] jquery.html Cycles:180 Average:24525.98 Median:410253.46 stddev:67632.06 (16.5%) stddev-sans-first:67797.44 22:26:00 INFO - PROCESS | 2765 | Values: 361.2 367.3 369.0 382.5 384.3 15758.5 16453.4 17005.2 17014.1 17064.3 15755.8 16313.3 16877.2 16953.7 16978.5 4972.8 5107.2 5135.2 5150.3 5155.7 3711.8 3915.7 5064.2 5377.1 5725.3 5647.9 5680.5 5710.4 5715.7 5716.7 5596.5 5655.3 5712.2 5828.2 5842.7 3328.3 4757.2 5100.0 5113.3 5127.6 18745.9 19379.7 19503.5 19678.9 19693.4 1869.1 1933.2 1942.4 2033.8 2047.7 12530.9 12586.4 12626.2 12907.3 13093.2 1717.3 1754.8 1767.0 1770.7 1791.0 62473.0 63035.4 63151.7 63988.7 64278.7 9384.5 9451.8 9813.7 10235.0 10411.3 13658.1 13716.4 13722.9 13723.9 13750.8 7811.0 7849.0 7863.7 7867.0 8019.4 7646.4 7659.8 7763.3 7796.2 7799.8 6129.0 6190.7 6227.3 6249.7 6375.2 1543.1 1676.2 1677.3 1681.2 1711.0 834.2 898.6 908.2 909.3 935.9 16391.1 17225.6 18280.5 18482.4 18847.2 838.2 850.0 870.5 877.3 902.7 8566.5 8575.9 8678.3 8726.4 8756.9 405178.0 408499.0 410222.9 410284.0 421874.0 78232.6 78631.0 80676.6 80726.0 81292.2 883.5 959.7 998.9 1011.9 1021.4 14369.6 14429.7 14508.6 14523.1 15031.7 30615.8 30653.2 31042.4 31090.0 31826.2 43770.3 44020.3 44452.0 44520.8 44923.3 6800.9 7114.4 7174.0 7274.8 7320.7 10506.5 11443.9 11542.9 11712.9 11732.9 9746.5 9832.3 9954.2 10014.2 10097.7 9857.5 10001.2 10050.3 10127.6 10198.0 10100.3 10116.0 10436.1 10447.2 10590.5 7335.7 7378.2 7404.7 7474.1 7819.3 10173.2 10371.9 10421.6 10423.1 10466.4 22:26:00 INFO - PROCESS | 2765 | 22:26:00 INFO - PROCESS | 2765 | [#3] mootools.html Cycles:180 Average:5438.48 Median:6356.86 stddev:2901.85 (45.6%) stddev-sans-first:2893.13 22:26:00 INFO - PROCESS | 2765 | Values: 1276.9 1382.5 1421.5 1548.5 1802.4 6586.8 7636.0 7837.8 7851.7 7859.8 7611.7 7782.2 7790.7 7792.6 7801.8 1874.4 2166.7 2205.1 2236.3 2251.2 2260.2 2280.3 2281.6 2284.0 2285.8 2218.9 2261.6 2262.5 2263.2 2264.1 2185.9 2194.3 2195.6 2197.2 2213.1 2128.3 2141.5 2145.8 2148.2 2151.4 7859.4 7971.2 7981.3 7991.0 8005.6 4527.6 4656.6 4673.0 4678.4 4680.5 2902.9 2934.2 3002.8 3024.1 3025.7 972.8 1699.2 1714.2 1733.8 1767.6 10291.0 10400.3 10433.8 10438.8 10446.6 3920.5 3986.8 4134.5 4147.7 4173.7 8558.7 8574.3 8602.6 8608.6 8611.2 4062.6 4602.2 4602.2 4603.3 4612.1 3863.6 3867.1 3871.7 3879.6 4212.2 3457.5 3529.2 3594.4 3596.8 3597.5 1098.5 1102.2 1110.8 1112.2 1117.3 995.6 1008.0 1013.0 1099.3 1261.9 7330.0 7412.6 7533.9 7553.6 7572.7 436.3 437.8 438.5 438.8 443.9 5765.5 5896.1 5950.0 5958.4 5961.2 9299.0 9370.4 9665.1 9713.9 9842.2 9665.1 9772.6 9801.1 9876.3 9901.1 7219.8 7562.9 7576.3 7580.8 7598.8 7200.7 7289.4 7324.3 7396.0 7402.3 9075.4 9090.1 9179.4 9251.1 9340.2 8959.5 9087.5 9230.6 9306.7 9317.4 5667.2 6054.8 6203.1 6517.0 6618.6 7341.0 7353.1 7382.9 7401.3 7406.6 6616.0 6659.0 6750.0 6875.0 6917.5 6569.3 6626.0 6675.0 6682.1 6778.5 6881.1 6930.6 6956.5 6970.2 6981.4 6567.7 6639.4 6642.9 6649.6 6656.7 6510.6 6558.2 6586.5 6588.8 6604.2 22:26:00 INFO - PROCESS | 2765 | 22:26:00 INFO - PROCESS | 2765 | [#4] prototype.html Cycles:180 Average:4422.44 Median:5102.51 stddev:1299.29 (25.5%) stddev-sans-first:1265.79 22:26:00 INFO - PROCESS | 2765 | Values: 312.5 316.6 320.5 320.7 321.9 4936.9 5126.8 5148.4 5167.5 5171.1 5049.2 5072.1 5102.3 5102.8 5106.1 3680.2 3807.4 3829.7 3947.9 3953.6 3925.5 3936.4 3938.3 3943.2 3954.6 3910.1 3910.6 3921.5 3923.4 3927.7 3668.4 3755.3 3936.4 3939.8 3943.5 3429.0 3443.6 3444.9 3446.6 3449.2 4808.6 4819.1 4845.7 4853.7 4858.0 4265.8 4458.9 4490.5 4512.3 4513.2 5279.2 5281.5 5284.3 5310.6 5350.9 3775.3 3781.4 3781.7 3782.1 3787.8 5458.6 5478.0 5529.3 5533.1 5603.2 3811.3 3820.1 3844.4 3848.4 3858.2 3886.3 3898.5 3902.1 3903.7 3905.3 4433.2 4437.0 4486.6 4493.0 4501.4 5064.1 5322.0 5336.5 5395.8 5410.3 1324.6 1344.8 1352.2 1354.6 1361.8 854.4 883.7 915.2 930.2 934.2 4381.6 4616.3 4632.2 4729.5 4809.9 5532.9 5549.1 5561.5 5565.2 5568.3 4652.1 4760.3 4770.3 4777.3 4791.0 2932.0 2946.6 2953.9 2954.9 2956.2 5242.0 5244.7 5258.9 5260.2 5273.4 5532.0 5646.9 5647.5 5651.4 5651.5 5199.8 5216.3 5221.6 5249.1 5251.6 5497.6 5508.8 5512.2 5513.7 5539.4 5165.8 5471.7 5474.2 5480.1 5487.7 5247.4 5275.7 5278.1 5284.9 5306.3 3838.2 3855.1 3859.2 3860.3 3865.9 5245.4 5554.9 5555.2 5556.2 5565.4 5352.9 5362.1 5365.5 5383.8 5403.1 5181.5 5364.0 5365.0 5376.5 5397.2 5256.9 5280.2 5287.5 5297.9 5303.3 5073.3 5154.6 5317.3 5344.7 5352.4 5213.3 5238.4 5254.8 5258.3 5268.8 22:26:00 INFO - PROCESS | 2765 | 22:26:00 INFO - PROCESS | 2765 | [#5] yui.html Cycles:180 Average:12485.46 Median:44064.95 stddev:14041.99 (31.9%) stddev-sans-first:14053.05 22:26:00 INFO - PROCESS | 2765 | Values: 607.4 623.4 636.0 647.5 672.8 11987.9 12664.3 12735.9 12919.4 12971.2 12567.9 12606.6 12659.2 12686.0 12692.6 658.9 787.6 820.0 826.1 826.8 824.8 830.8 830.9 831.1 831.4 838.9 843.6 843.7 843.9 844.6 681.6 827.9 830.4 833.7 857.9 628.7 628.9 629.0 629.2 629.6 12879.0 12950.8 12965.4 12968.9 12973.4 11846.8 12172.4 12408.6 12445.3 12531.8 9840.1 9855.8 9868.2 9941.5 10072.7 3291.5 3302.9 3334.9 3381.5 3381.8 43906.3 43998.3 44131.6 44447.0 45149.3 9488.8 9488.8 9554.1 9726.7 9742.9 17834.3 17865.6 18113.5 18122.2 18143.5 5898.2 6030.2 6136.4 6219.2 6312.6 3637.2 3783.7 3803.8 3822.7 3880.9 2745.8 2819.9 2823.1 2827.2 2827.3 474.7 478.1 485.8 493.7 516.6 531.3 595.2 596.5 609.0 615.7 7666.4 7675.3 7754.1 7814.3 7816.4 508.0 530.8 577.3 579.0 591.0 3766.5 3849.2 3900.0 3940.1 3967.6 54245.5 57220.4 57401.4 57623.7 57636.4 36995.8 39877.8 40009.8 41980.2 49199.5 38108.0 38491.0 38995.8 39316.4 39696.2 7688.9 7962.8 8000.8 8053.6 8242.4 25983.7 26250.3 26629.1 26948.7 27737.3 35092.3 36539.8 36620.8 36742.0 36955.6 9865.5 10037.4 10103.8 10232.7 10261.6 11444.6 11662.0 11768.1 11853.9 11865.6 10834.6 11080.8 11286.7 11317.7 11618.7 10964.7 11059.5 11499.2 11547.6 11842.2 10883.4 11174.8 11504.4 11536.2 11563.2 9318.2 9521.0 9530.8 9753.7 9922.5 9238.3 9264.2 9336.3 9612.9 9665.2 22:26:00 INFO - PROCESS | 2765 | -------- Summary: end -------- 22:26:00 INFO - PROCESS | 2765 | 22:26:01 INFO - TEST-INFO | 2765: exit 0 22:26:01 INFO - TEST-OK | dromaeo_css | took 1117363ms 22:26:01 INFO - TEST-START | kraken 22:26:01 INFO - operating with platform_type : linux_ 22:26:01 INFO - Initialising browser for kraken test... 22:26:01 INFO - TEST-INFO | started process 2988 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9rvu4q/profile http://localhost:39795/getInfo.html) 22:26:05 INFO - PROCESS | 2988 | __metrics Screen width/height:1600/1200 22:26:05 INFO - PROCESS | 2988 | colorDepth:24 22:26:05 INFO - PROCESS | 2988 | Browser inner width/height: 1024/697 22:26:05 INFO - PROCESS | 2988 | __metrics 22:26:06 ERROR - PROCESS | 2988 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:26:07 INFO - TEST-INFO | 2988: exit 0 22:26:07 INFO - Browser initialized. 22:26:07 INFO - Running cycle 1/1 for kraken test... 22:26:07 INFO - TEST-INFO | started process 3069 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9rvu4q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:26:19 INFO - PROCESS | 3069 | RSS: Main: 154189824 22:26:19 INFO - PROCESS | 3069 | 22:26:21 INFO - PROCESS | 3069 | Cycle 1(1): loaded http://localhost:39795/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39795/tests/kraken/driver.html?testName=audio-beat-detection) 22:26:22 INFO - PROCESS | 3069 | RSS: Main: 195047424 22:26:22 INFO - PROCESS | 3069 | 22:26:25 INFO - PROCESS | 3069 | Cycle 1(1): loaded http://localhost:39795/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39795/tests/kraken/driver.html?testName=audio-dft) 22:26:25 INFO - PROCESS | 3069 | RSS: Main: 185163776 22:26:25 INFO - PROCESS | 3069 | 22:26:28 INFO - PROCESS | 3069 | Cycle 1(1): loaded http://localhost:39795/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39795/tests/kraken/driver.html?testName=audio-fft) 22:26:29 INFO - PROCESS | 3069 | RSS: Main: 170496000 22:26:29 INFO - PROCESS | 3069 | 22:26:31 INFO - PROCESS | 3069 | Cycle 1(1): loaded http://localhost:39795/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39795/tests/kraken/driver.html?testName=audio-oscillator) 22:26:31 INFO - PROCESS | 3069 | RSS: Main: 172408832 22:26:31 INFO - PROCESS | 3069 | 22:26:34 INFO - PROCESS | 3069 | Cycle 1(1): loaded http://localhost:39795/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39795/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:26:34 INFO - PROCESS | 3069 | RSS: Main: 174059520 22:26:34 INFO - PROCESS | 3069 | 22:26:37 INFO - PROCESS | 3069 | Cycle 1(1): loaded http://localhost:39795/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39795/tests/kraken/driver.html?testName=imaging-darkroom) 22:26:38 INFO - PROCESS | 3069 | RSS: Main: 174215168 22:26:38 INFO - PROCESS | 3069 | 22:26:41 INFO - PROCESS | 3069 | Cycle 1(1): loaded http://localhost:39795/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39795/tests/kraken/driver.html?testName=imaging-desaturate) 22:26:42 INFO - PROCESS | 3069 | RSS: Main: 174895104 22:26:42 INFO - PROCESS | 3069 | 22:26:45 INFO - PROCESS | 3069 | Cycle 1(1): loaded http://localhost:39795/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39795/tests/kraken/driver.html?testName=json-parse-financial) 22:26:45 INFO - PROCESS | 3069 | RSS: Main: 174616576 22:26:45 INFO - PROCESS | 3069 | 22:26:47 INFO - PROCESS | 3069 | Cycle 1(1): loaded http://localhost:39795/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39795/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:26:48 INFO - PROCESS | 3069 | RSS: Main: 184582144 22:26:48 INFO - PROCESS | 3069 | 22:26:50 INFO - PROCESS | 3069 | Cycle 1(1): loaded http://localhost:39795/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39795/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:26:50 INFO - PROCESS | 3069 | RSS: Main: 183427072 22:26:50 INFO - PROCESS | 3069 | 22:26:52 INFO - PROCESS | 3069 | Cycle 1(1): loaded http://localhost:39795/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39795/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:26:53 INFO - PROCESS | 3069 | RSS: Main: 197529600 22:26:53 INFO - PROCESS | 3069 | 22:26:56 INFO - PROCESS | 3069 | Cycle 1(1): loaded http://localhost:39795/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39795/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:26:56 INFO - PROCESS | 3069 | RSS: Main: 202919936 22:26:56 INFO - PROCESS | 3069 | 22:26:59 INFO - PROCESS | 3069 | Cycle 1(1): loaded http://localhost:39795/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39795/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:27:00 INFO - PROCESS | 3069 | RSS: Main: 203173888 22:27:00 INFO - PROCESS | 3069 | 22:27:02 INFO - PROCESS | 3069 | Cycle 1(1): loaded http://localhost:39795/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39795/tests/kraken/driver.html?testName=ai-astar) 22:27:02 INFO - PROCESS | 3069 | RSS: Main: 265695232 22:27:02 INFO - PROCESS | 3069 | 22:27:02 INFO - PROCESS | 3069 | __start_tp_report 22:27:02 INFO - PROCESS | 3069 | _x_x_mozilla_page_load 22:27:02 INFO - PROCESS | 3069 | _x_x_mozilla_page_load_details 22:27:02 INFO - PROCESS | 3069 | |i|pagename|runs| 22:27:02 INFO - PROCESS | 3069 | |0;ai-astar;111;114;107;115;117;113;102;114;112;113 22:27:02 INFO - PROCESS | 3069 | |1;audio-beat-detection;163;130;159;184;135;155;157;133;179;138 22:27:02 INFO - PROCESS | 3069 | |2;audio-dft;161;162;162;160;160;160;161;160;162;163 22:27:02 INFO - PROCESS | 3069 | |3;audio-fft;73;73;101;94;76;77;73;123;97;73 22:27:02 INFO - PROCESS | 3069 | |4;audio-oscillator;93;93;152;94;93;93;138;94;95;134 22:27:02 INFO - PROCESS | 3069 | |5;imaging-gaussian-blur;116;117;116;117;116;117;117;117;117;117 22:27:02 INFO - PROCESS | 3069 | |6;imaging-darkroom;147;146;146;146;146;145;146;146;146;145 22:27:02 INFO - PROCESS | 3069 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;94 22:27:02 INFO - PROCESS | 3069 | |8;json-parse-financial;65;64;66;64;64;65;65;75;63;63 22:27:02 INFO - PROCESS | 3069 | |9;json-stringify-tinderbox;63;64;64;65;64;64;65;65;65;65 22:27:02 INFO - PROCESS | 3069 | |10;stanford-crypto-aes;85;85;85;87;86;93;84;84;84;83 22:27:02 INFO - PROCESS | 3069 | |11;stanford-crypto-ccm;143;138;136;138;143;146;137;137;146;139 22:27:02 INFO - PROCESS | 3069 | |12;stanford-crypto-pbkdf2;180;180;179;176;176;181;168;170;170;170 22:27:02 INFO - PROCESS | 3069 | |13;stanford-crypto-sha256-iterative;72;80;71;73;71;73;71;70;71;69 22:27:02 INFO - PROCESS | 3069 | __end_tp_report 22:27:02 INFO - PROCESS | 3069 | __start_cc_report 22:27:02 INFO - PROCESS | 3069 | _x_x_mozilla_cycle_collect,1213 22:27:02 INFO - PROCESS | 3069 | __end_cc_report 22:27:02 INFO - PROCESS | 3069 | __startTimestamp1460179622375__endTimestamp 22:27:02 INFO - PROCESS | 3069 | 22:27:02 INFO - PROCESS | 3069 | ------- Summary: start ------- 22:27:02 INFO - PROCESS | 3069 | Number of tests: 14 22:27:02 INFO - PROCESS | 3069 | 22:27:02 INFO - PROCESS | 3069 | [#0] ai-astar Cycles:10 Average:111.80 Median:113.50 stddev:4.34 (3.8%) stddev-sans-first:4.59 22:27:02 INFO - PROCESS | 3069 | Values: 111.0 114.0 107.0 115.0 117.0 113.0 102.0 114.0 112.0 113.0 22:27:02 INFO - PROCESS | 3069 | 22:27:02 INFO - PROCESS | 3069 | [#1] audio-beat-detection Cycles:10 Average:153.30 Median:158.00 stddev:19.06 (12.1%) stddev-sans-first:19.89 22:27:02 INFO - PROCESS | 3069 | Values: 163.0 130.0 159.0 184.0 135.0 155.0 157.0 133.0 179.0 138.0 22:27:02 INFO - PROCESS | 3069 | 22:27:02 INFO - PROCESS | 3069 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.50 stddev:1.10 (0.7%) stddev-sans-first:1.17 22:27:02 INFO - PROCESS | 3069 | Values: 161.0 162.0 162.0 160.0 160.0 160.0 161.0 160.0 162.0 163.0 22:27:02 INFO - PROCESS | 3069 | 22:27:02 INFO - PROCESS | 3069 | [#3] audio-fft Cycles:10 Average:86.00 Median:74.50 stddev:17.11 (23.0%) stddev-sans-first:17.49 22:27:02 INFO - PROCESS | 3069 | Values: 73.0 73.0 101.0 94.0 76.0 77.0 73.0 123.0 97.0 73.0 22:27:02 INFO - PROCESS | 3069 | 22:27:02 INFO - PROCESS | 3069 | [#4] audio-oscillator Cycles:10 Average:107.90 Median:93.00 stddev:23.51 (25.3%) stddev-sans-first:24.31 22:27:02 INFO - PROCESS | 3069 | Values: 93.0 93.0 152.0 94.0 93.0 93.0 138.0 94.0 95.0 134.0 22:27:02 INFO - PROCESS | 3069 | 22:27:02 INFO - PROCESS | 3069 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 22:27:02 INFO - PROCESS | 3069 | Values: 116.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 22:27:02 INFO - PROCESS | 3069 | 22:27:02 INFO - PROCESS | 3069 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.44 22:27:02 INFO - PROCESS | 3069 | Values: 147.0 146.0 146.0 146.0 146.0 145.0 146.0 146.0 146.0 145.0 22:27:02 INFO - PROCESS | 3069 | 22:27:02 INFO - PROCESS | 3069 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 22:27:02 INFO - PROCESS | 3069 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 22:27:02 INFO - PROCESS | 3069 | 22:27:02 INFO - PROCESS | 3069 | [#8] json-parse-financial Cycles:10 Average:65.40 Median:65.00 stddev:3.50 (5.4%) stddev-sans-first:3.71 22:27:02 INFO - PROCESS | 3069 | Values: 65.0 64.0 66.0 64.0 64.0 65.0 65.0 75.0 63.0 63.0 22:27:02 INFO - PROCESS | 3069 | 22:27:02 INFO - PROCESS | 3069 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:65.00 stddev:0.70 (1.1%) stddev-sans-first:0.53 22:27:02 INFO - PROCESS | 3069 | Values: 63.0 64.0 64.0 65.0 64.0 64.0 65.0 65.0 65.0 65.0 22:27:02 INFO - PROCESS | 3069 | 22:27:02 INFO - PROCESS | 3069 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:85.00 stddev:2.84 (3.3%) stddev-sans-first:3.00 22:27:02 INFO - PROCESS | 3069 | Values: 85.0 85.0 85.0 87.0 86.0 93.0 84.0 84.0 84.0 83.0 22:27:02 INFO - PROCESS | 3069 | 22:27:02 INFO - PROCESS | 3069 | [#11] stanford-crypto-ccm Cycles:10 Average:140.30 Median:141.00 stddev:3.83 (2.7%) stddev-sans-first:3.94 22:27:02 INFO - PROCESS | 3069 | Values: 143.0 138.0 136.0 138.0 143.0 146.0 137.0 137.0 146.0 139.0 22:27:02 INFO - PROCESS | 3069 | 22:27:02 INFO - PROCESS | 3069 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.00 Median:177.50 stddev:5.03 (2.8%) stddev-sans-first:5.00 22:27:02 INFO - PROCESS | 3069 | Values: 180.0 180.0 179.0 176.0 176.0 181.0 168.0 170.0 170.0 170.0 22:27:02 INFO - PROCESS | 3069 | 22:27:02 INFO - PROCESS | 3069 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.10 Median:71.50 stddev:3.03 (4.2%) stddev-sans-first:3.22 22:27:02 INFO - PROCESS | 3069 | Values: 72.0 80.0 71.0 73.0 71.0 73.0 71.0 70.0 71.0 69.0 22:27:02 INFO - PROCESS | 3069 | -------- Summary: end -------- 22:27:02 INFO - PROCESS | 3069 | 22:27:03 INFO - TEST-INFO | 3069: exit 0 22:27:03 INFO - TEST-OK | kraken | took 62344ms 22:27:03 INFO - SUITE-END | took 1179s 22:27:03 INFO - Completed test suite (00:19:39) 22:27:03 INFO - javascript benchmark 22:27:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2609.3476630842288, 2613.085420102963, 2624.6981597116337, 2636.657234559507, 2653.65502484677, 4475.172093162759, 4553.635709143269, 4637.744924029177, 4660.0, 4666.48668646449, 4597.88505287368, 4637.536246375361, 4694.953050469494, 4712.3638308828295, 4719.174144524712, 4179.853705120321, 4215.957840421603, 4236.872893813191, 4277.25148099083, 4284.164587905359, 4232.830686772525, 4287.957120428802, 4349.0, 4378.62781663559, 4389.692721509496, 4139.855105071339, 4312.0, 4337.761423121727, 4348.543402942693, 4350.216960947028, 4173.436586060873, 4179.770112643803, 4241.045764702948, 4313.331433627762, 4339.0237196630505, 4255.1064276501975, 4257.510386305553, 4264.296391095466, 4267.4025636410925, 4306.44016277885, 4554.362389265505, 4556.498785133633, 4580.083983203339, 4582.725036497787, 4593.425821772278, 4822.397200349957, 4986.152354099811, 5027.924581131286, 5062.139436295838, 5077.593792496591, 5032.0, 5040.092783299005, 5059.266406371093, 5063.240513922904, 5064.5441910228255, 4532.0482698632995, 4720.551547602938, 4724.574788269072, 4727.834525791581, 4759.619230461555, 5135.4094279157625, 5164.612654050961, 5184.766685499161, 5213.983273261678, 5241.895162096736, 4887.0, 4897.559219670246, 4898.485659005824, 4902.779374928136, 4944.208926571731, 4796.448408433005, 4958.181899986534, 4978.8755281118265, 4980.352554167935, 5016.899662006739, 4870.245112007645, 4881.682690625098, 4895.167821470359, 4924.8768780780765, 4937.21004639256, 4890.902181956341, 4898.02039592083, 4900.166971614834, 4901.43633482147, 4949.480304567968, 4213.494380674339, 4273.252180868398, 4288.335308027261, 4292.5492823253735, 4325.199838029975, 3684.0, 3706.240220754739, 3741.064733816546, 3743.2139250757646, 3764.6800021997888, 4293.935590966138, 4296.613304802583, 4301.978490107529, 4314.56854314566, 4346.434963454731, 4813.133635945564, 4946.159152944008, 4954.578860796801, 4956.3804524434445, 5022.070916880389, 4273.465816772903, 4303.591158839905, 4308.892277693083, 4333.739975601474, 4337.7397356158735, 4528.547145285445, 4530.909381812411, 4547.909041819145, 4557.088582283556, 4584.977075114603, 4547.727136371828, 4673.135469938073, 4752.19212733843, 4765.523447655207, 4766.45185803637, 4911.828086017115, 4929.630277729257, 4936.3829521309835, 4983.202687569971, 4983.277424773315, 4660.300954856799, 4683.672142949961, 4691.085238378483, 4696.506866778939, 4724.692894961817, 4736.644751643572, 4866.172750632471, 4923.286123512143, 4955.132851751001, 5019.297298378157, 5019.372578427697, 5021.72380519075, 5022.598192144546, 5033.697978121324, 5051.570616497639, 4860.805567777249, 4867.41591009067, 4873.171560834738, 4874.58566021878, 4904.215325547895, 4637.46669133054, 4758.738269395217, 4828.517148285144, 4856.757162141808, 4900.828471003498, 4719.0, 4735.218688916428, 4742.2175341069715, 4743.976280118577, 4795.856124316276, 4842.927356089732, 4844.079624871263, 4850.490698476609, 4851.393575803025, 4856.732879691651, 4582.358469814162, 4690.695104818176, 4719.716816990992, 4751.144793936986, 4778.808847646194], "value": 4570.581399820205, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.4081035318095, 591.5267785771382, 592.632567807959, 611.2084850119094, 618.0327787013326, 34096.31807363854, 35311.11722206949, 35339.82330088352, 35494.822525887364, 35502.644973550254, 37869.86390408292, 38557.61442385575, 38681.80659096708, 38802.22395552087, 38853.94898663177, 7629.771106866789, 7802.960985195066, 7821.960890195541, 7826.491278066936, 7827.217278272155, 7651.502652327608, 7743.8838417423785, 7767.728129515468, 7933.484323518982, 7934.761957141295, 7906.248906353887, 8020.558869262218, 8024.037115546143, 8026.157253488387, 8028.438009339348, 7891.644875980594, 7935.72224972129, 7956.6817327306835, 7957.6021198939825, 7957.840843183133, 7863.095743989457, 7955.0, 7970.362371010306, 7972.3622110231045, 7976.7208147714555, 37442.81278593617, 37747.62252377496, 37847.24305513902, 37851.62148378536, 37897.24205515902, 2953.7636989040825, 3102.115896969353, 3106.1613364391487, 3338.282269312085, 3346.983265083659, 28722.0, 28940.8552957236, 28990.130296091153, 29574.704252957625, 29779.851100744574, 3422.5379573757723, 3484.703800176988, 3487.110786749388, 3523.3481805865995, 3545.592256890465, 178192.0, 178269.0, 178493.1075344628, 178545.0, 179076.0, 51219.48780512222, 51306.74346628243, 51354.0, 51371.22943155855, 51400.22899656508, 58412.70793646004, 60178.398216018155, 60250.0, 60260.56352110708, 60419.09371359433, 15488.07071575709, 15878.44425445127, 15928.283227254802, 15930.840691593168, 15931.283092260875, 10184.745381365525, 10251.692449226535, 10260.948695256477, 10266.281360304856, 10266.743331416774, 18562.535936601693, 18614.0, 18674.253029878924, 18690.34583789561, 18749.906250468932, 6720.6639668016405, 6857.245702972669, 6919.827004324932, 7008.7546935857, 7041.5422997505, 849.4351256414416, 907.9785241603197, 909.5952301225891, 920.3097676742443, 978.2516374973151, 26741.866290668422, 27965.860170699423, 28434.573481397794, 28505.429891402055, 28506.0, 972.5040229483014, 980.8038392321564, 1005.215931573374, 1049.6903413493037, 1074.8292537015834, 14252.0, 14786.890983176305, 14866.554003379915, 14884.479043233436, 15137.318820653098, 341166.0, 347251.0, 347916.0, 348257.0, 350460.0, 48058.519414806105, 48827.75586122047, 49008.50991490111, 49050.75474622604, 49119.50880491149, 1104.7127746785893, 1189.4766302826729, 1217.6103646833105, 1233.6237447578574, 1258.5972488803677, 26599.867000665647, 27286.317842054108, 27353.0, 28181.57727634046, 28219.43561128807, 37831.243375131795, 38258.80870595629, 38476.2304753909, 38536.42195367016, 38644.0, 223764.0, 223772.0, 224090.0, 225100.0, 225574.0, 24851.502969940862, 26045.869770651025, 26052.478950420507, 26057.348566285993, 26071.217863464128, 41115.1776964465, 41156.58843411647, 41397.0, 41979.0, 42446.0, 34303.82848085744, 35246.0, 35491.11272218215, 35578.28843423065, 36041.63958360383, 34376.0, 34741.65258347384, 35013.47479787754, 35218.82390588031, 35330.823345884135, 35298.11754706153, 35596.466053008706, 35944.281114377045, 36352.63647363493, 36703.63296367109, 30959.535606966365, 31528.684713152576, 31686.366272674877, 31797.364052718352, 31851.0, 24577.877110614332, 25298.74701252964, 25348.366290842878, 25663.358416039748, 25672.229833105037], "value": 17104.24328146831, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.20174414543857, 367.28562945071843, 368.97232707546937, 382.49892640640763, 384.3331819293527, 15758.527244182664, 16453.424130155447, 17005.234764435616, 17014.149292535356, 17064.317427302925, 15755.763663545027, 16313.347466101372, 16877.15614219287, 16953.745693814602, 16978.49064528063, 4972.776225069881, 5107.233914912774, 5135.152699804527, 5150.3047088642925, 5155.74221288934, 3711.8329675164546, 3915.725899187058, 5064.2403639454005, 5377.11277639189, 5725.255716756837, 5647.858803529924, 5680.460356266148, 5710.400407957167, 5715.685637289947, 5716.7141642917895, 5596.468335508141, 5655.293088363975, 5712.171735098429, 5828.242328497311, 5842.737076831553, 3328.251143492719, 4757.215059515176, 5100.030994111107, 5113.284140220372, 5127.589792816566, 18745.9062704687, 19379.709304360447, 19503.512412189666, 19678.90160549188, 19693.409197723948, 1869.140195510067, 1933.2460340467228, 1942.3784388995527, 2033.7864524224892, 2047.6518991771434, 12530.937345313216, 12586.37068146589, 12626.24242545441, 12907.290099044549, 13093.214407135602, 1717.252994947202, 1754.754334393186, 1767.0419895583943, 1770.6989811732037, 1790.9552261193444, 62473.0, 63035.36964630341, 63151.68424157896, 63988.680056599886, 64278.71442571169, 9384.5307734613, 9451.763705907408, 9813.705588832347, 10235.0, 10411.271211015157, 13658.112222705691, 13716.382762775698, 13722.862771372358, 13723.931380343034, 13750.793738093937, 7811.0, 7848.960755196187, 7863.685452581947, 7867.0, 8019.43863929531, 7646.3882889368715, 7659.808504787314, 7763.301302882767, 7796.181400952932, 7799.844003119906, 6129.0, 6190.721417536221, 6227.314995350508, 6249.6875156242, 6375.23497180332, 1543.1127101916443, 1676.1954261954331, 1677.3206851225273, 1681.2266357475698, 1710.9905155958045, 834.1866679987086, 898.5911410308294, 908.1780988205685, 909.3134683314056, 935.9438433694, 16391.09848958295, 17225.569360765832, 18280.45158645243, 18482.445526634223, 18847.24611015544, 838.1534650003418, 849.9830003400021, 870.5299138465158, 877.2674816528271, 902.6840605787921, 8566.528840913685, 8575.914240857512, 8678.262347700389, 8726.432781869158, 8756.8686469703, 405178.0, 408499.0, 410222.92659270944, 410284.0, 421874.0, 78232.60883695545, 78631.0, 80676.59661701653, 80726.0, 81292.18707812847, 883.4919921045424, 959.6928982725461, 998.8701468809008, 1011.9392836429838, 1021.402479549457, 14369.56891293263, 14429.711405772036, 14508.637284067983, 14523.128612283297, 15031.699366012837, 30615.846920765252, 30653.23366915845, 31042.379152417278, 31090.0, 31826.204344891565, 43770.34344484771, 44020.33969490396, 44452.0, 44520.77739611411, 44923.32615010712, 6800.93199068003, 7114.430845532448, 7174.0, 7274.781756547312, 7320.707171713072, 10506.527206275583, 11443.885561144281, 11542.942285288857, 11712.941435292769, 11732.88267117352, 9746.463944483121, 9832.31173817826, 9954.153896918842, 10014.19886409071, 10097.747556311151, 9857.457839818879, 10001.199904007517, 10050.296479246383, 10127.594896204364, 10198.0, 10100.343477673927, 10116.0, 10436.112930401001, 10447.216458765472, 10590.523426445674, 7335.669894854851, 7378.225286344857, 7404.740834070782, 7474.140473845578, 7819.257170568787, 10173.186145108522, 10371.896281037394, 10421.583136674448, 10423.11403530678, 10466.424346661006], "value": 8228.230130264337, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1276.9170003949748, 1382.4884792626726, 1421.4882642248788, 1548.4967385599682, 1802.4322338463382, 6586.835329116774, 7635.961820190898, 7837.843243135134, 7851.685932562691, 7859.842803143941, 7611.733589324361, 7782.221777822215, 7790.727324543642, 7792.571408572526, 7801.765947021584, 1874.4189301316567, 2166.685830554569, 2205.095910676619, 2236.2732112063563, 2251.189571754167, 2260.1976298414074, 2280.304507125326, 2281.566502364554, 2283.954320913581, 2285.7942785149335, 2218.9001494932686, 2261.6381378979368, 2262.46831994482, 2263.219189379661, 2264.116994372196, 2185.9344219673435, 2194.297824696098, 2195.6057903231485, 2197.1760589778833, 2213.0815711479718, 2128.287023847013, 2141.453929248047, 2145.7639659637425, 2148.151480165326, 2151.397608669575, 7859.449838511307, 7971.163027882105, 7981.281684648409, 7990.960045199737, 8005.599720013976, 4527.615152712024, 4656.580907718288, 4673.018666080094, 4678.391809064799, 4680.455449701591, 2902.941941161165, 2934.207763903734, 3002.8348440835744, 3024.138120635608, 3025.667176610571, 972.8054389122133, 1699.2268517824484, 1714.2285971312958, 1733.8092809790912, 1767.5846176148596, 10291.02235287654, 10400.323978941344, 10433.843492347622, 10438.79122417555, 10446.63436779709, 3920.5491368492417, 3986.7807270599815, 4134.524529679125, 4147.709660323749, 4173.707840451139, 8558.700445484377, 8574.314054875595, 8602.612882420306, 8608.569571521399, 8611.181937715906, 4062.6343629073526, 4602.194615942197, 4602.217623004098, 4603.309503574424, 4612.123696497655, 3863.613638636114, 3867.0719027433215, 3871.728978971445, 3879.6120387960977, 4212.199682060399, 3457.4640930655787, 3529.2412131391875, 3594.370985077601, 3596.813051692935, 3597.460380942827, 1098.4727330881221, 1102.2339474065607, 1110.8444817725524, 1112.232559533919, 1117.251441534174, 995.581855620641, 1007.9798404031878, 1012.9819531370925, 1099.301943266032, 1261.8611952685196, 7329.963350183321, 7412.592307423036, 7533.886991695129, 7553.622318884144, 7572.697092116364, 436.3171636389041, 437.80955284451363, 438.5461047815559, 438.8025388575154, 443.86683994802075, 5765.509931655856, 5896.086106653475, 5950.047992321294, 5958.374370691015, 5961.225040744762, 9299.0, 9370.437773733598, 9665.130138287588, 9713.90286097144, 9842.212622990144, 9665.130138287588, 9772.609095636095, 9801.11789938909, 9876.308658393844, 9901.108900199017, 7219.819504512324, 7562.924370756332, 7576.3181313682035, 7580.772576822704, 7598.848023039508, 7200.71197152108, 7289.4168466523615, 7324.267573242633, 7395.963020184865, 7402.259774022555, 9075.410098343851, 9090.090990900857, 9179.403338783224, 9251.074892510964, 9340.206082482793, 8959.462432254086, 9087.545622718706, 9230.584623691815, 9306.72079837606, 9317.39436936597, 5667.2349232854685, 6054.75780968774, 6203.06953956892, 6517.0, 6618.602883826986, 7341.0, 7353.080864891888, 7382.852342953218, 7401.33387995083, 7406.555606663617, 6616.0, 6658.966705166443, 6749.9662501689145, 6875.037494750639, 6917.481188910751, 6569.343065693583, 6626.0392243123515, 6675.0, 6682.131322927989, 6778.525503214728, 6881.10545629065, 6930.584164949917, 6956.478264130109, 6970.198427180939, 6981.441484681111, 6567.737290508326, 6639.402453779183, 6642.933570664231, 6649.63427011519, 6656.73373065072, 6510.641914694737, 6558.213014438298, 6586.5389422739945, 6588.8023359299295, 6604.174478190226], "value": 4369.478362894806, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.48752046643494, 316.5773692121018, 320.51762098042445, 320.66650683289396, 321.9323941972185, 4936.925946110807, 5126.794928202877, 5148.3564554430695, 5167.534921857032, 5171.0692075426405, 5049.166887463564, 5072.13773658478, 5102.260172275018, 5102.754787893325, 5106.106431374513, 3680.2271522980204, 3807.4288856671583, 3829.7127715421316, 3947.8748556661358, 3953.644172024517, 3925.4504369388164, 3936.4488971544006, 3938.2714197873483, 3943.2113577284513, 3954.62431069048, 3910.1397692507603, 3910.6284902934317, 3921.4902062731803, 3923.431102490137, 3927.7446965947265, 3668.413053911375, 3755.324041672498, 3936.350502167139, 3939.7589759225752, 3943.4676318696897, 3428.9657103429145, 3443.5867695876655, 3444.9311013779834, 3446.638102999174, 3449.1721986723255, 4808.61531077513, 4819.1325561398935, 4845.70925744453, 4853.684510506841, 4857.951420485785, 4265.786710664485, 4458.910821783578, 4490.461144662629, 4512.345709872083, 4513.210188217049, 5279.208118782213, 5281.524662780368, 5284.260203571503, 5310.62825602208, 5350.892982140335, 3775.263823554408, 3781.4138808484727, 3781.6785573226307, 3782.0544863784053, 3787.810609469543, 5458.590605704588, 5478.0, 5529.313559364433, 5533.114701647757, 5603.215549823028, 3811.313963486544, 3820.0899550224885, 3844.38489841624, 3848.3842585186235, 3858.2476417098396, 3886.3004659161056, 3898.4737060497037, 3902.1415288636454, 3903.6877049835944, 3905.3165696003084, 4433.1577000369825, 4437.0, 4486.573775491323, 4493.0, 4501.437320334958, 5064.139096353629, 5322.0154271459905, 5336.466353364633, 5395.757190926418, 5410.296661433988, 1324.6291038509232, 1344.7713888638955, 1352.2022007015908, 1354.613935028512, 1361.7821148616174, 854.3677678517852, 883.7481317824389, 915.190056799737, 930.2325581395376, 934.1825902335456, 4381.649468042613, 4616.261398176276, 4632.2356811126465, 4729.527047295312, 4809.9038019240115, 5532.861678458071, 5549.112142057252, 5561.470595586246, 5565.248691426606, 5568.273835111128, 4652.092841895866, 4760.2625041860165, 4770.308305295782, 4777.331173635694, 4790.952090479051, 2932.003118939571, 2946.6316710411197, 2953.881844726187, 2954.926126846846, 2956.2461572298926, 5242.0, 5244.685318880879, 5258.947410525922, 5260.237265596467, 5273.367195936436, 5532.004239236895, 5646.943530564642, 5647.519960803378, 5651.406602306781, 5651.547876169897, 5199.818006369759, 5216.347956505437, 5221.582273418194, 5249.133892907627, 5251.6323857331145, 5497.560195184456, 5508.834734957958, 5512.173174023928, 5513.724313784375, 5539.362973258127, 5165.819196328111, 5471.671699698031, 5474.233607295061, 5480.123180291134, 5487.725613719378, 5247.396549396868, 5275.657082289639, 5278.1027225372545, 5284.867878302919, 5306.257124002565, 3838.1556057667267, 3855.1133239355668, 3859.1702783901596, 3860.285847118292, 3865.8646947356706, 5245.423003469692, 5554.861128471659, 5555.2222688822785, 5556.16657501378, 5565.415631358649, 5352.9464705354, 5362.142057270974, 5365.490278423544, 5383.784648614168, 5403.13549832025, 5181.455947125498, 5364.0, 5364.9731751341, 5376.489233522809, 5397.163439666858, 5256.868578285574, 5280.234366016983, 5287.4930644766055, 5297.947020529746, 5303.337082864642, 5073.289739436408, 5154.587632989277, 5317.335333083364, 5344.706041167773, 5352.41123476425, 5213.348331458567, 5238.397584277857, 5254.842354729364, 5258.291055406931, 5268.841934741964], "value": 4011.114195632226, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [607.3528461588162, 623.3890787028712, 636.0332294911734, 647.4690753582062, 672.754444627711, 11987.880121198785, 12664.303463309527, 12735.872641273585, 12919.354032298394, 12971.221726696405, 12567.874321256784, 12606.558770443036, 12659.240445573249, 12686.048546359038, 12692.619221423349, 658.9077529145924, 787.5904529644581, 819.9590020498981, 826.0789220019665, 826.7602395305354, 824.7608193623842, 830.8296799156188, 830.8670612701969, 831.1480732249432, 831.418007394823, 838.932885369172, 843.6077224090797, 843.6920524008754, 843.9198276163754, 844.6410275632862, 681.6216999565264, 827.8509868223717, 830.3896635972555, 833.6582001379436, 857.9399442038997, 628.6699482771581, 628.8585068359628, 629.0344321466526, 629.2260519560965, 629.6379581740472, 12879.03407244451, 12950.805737913939, 12965.35173241334, 12968.935155324163, 12973.41619627119, 11846.822297665542, 12172.391380430943, 12408.62774116778, 12445.315507647076, 12531.812022819666, 9840.11555511283, 9855.753606159904, 9868.161206297473, 9941.453220072894, 10072.697819065366, 3291.4600223720213, 3302.884399046022, 3334.866605335784, 3381.492776083607, 3381.847816848223, 43906.34140487895, 43998.340024899655, 44131.55868441307, 44447.0, 45149.322760158626, 9488.762780930532, 9488.765519529808, 9554.127434862668, 9726.659566915265, 9742.853857192147, 17834.286628534974, 17865.553361166076, 18113.54716132081, 18122.184501697455, 18143.455696329132, 5898.203742494794, 6030.216071910623, 6136.355682653257, 6219.222597175353, 6312.589681670768, 3637.2361804021452, 3783.6783873370523, 3803.8478460861256, 3822.6750726188584, 3880.8835734927998, 2745.752882240608, 2819.9295017624313, 2823.1107201231957, 2827.23664610554, 2827.3214428537412, 474.6511314184072, 478.0987837925466, 485.7862540482247, 493.7481884239064, 516.5867306155061, 531.2774626507946, 595.1548800702925, 596.5347029317139, 608.9543284253699, 615.6829232945037, 7666.3866890648615, 7675.270849269311, 7754.108277548155, 7814.335781458526, 7816.41376896735, 508.0347340053927, 530.8115618955293, 577.2870504926412, 578.9565782566324, 590.9704514774244, 3766.453864189677, 3849.1531862990096, 3899.9610003900166, 3940.0937784309767, 3967.6429121379215, 54245.45754542404, 57220.42779572151, 57401.42598573961, 57623.71188144032, 57636.423635763946, 36995.815020924725, 39877.80061099676, 40009.79995100064, 41980.16039679189, 49199.50800492021, 38108.04729881775, 38491.0, 38995.805020974716, 39316.41025384564, 39696.20607587832, 7688.884666730115, 7962.840743184988, 8000.759977200693, 8053.557054361832, 8242.381821363542, 25983.740162598133, 26250.343741406617, 26629.067982620516, 26948.730512694623, 27737.306567335978, 35092.298154037286, 36539.817300913324, 36620.81689591535, 36742.0, 36955.6304436963, 9865.45739984279, 10037.44794036335, 10103.848442273225, 10232.744181395226, 10261.58953641846, 11444.599439019594, 11661.950424461838, 11768.117391195523, 11853.863022690028, 11865.644030679094, 10834.566617335218, 11080.833787493355, 11286.66140015801, 11317.71705707364, 11618.6514404568, 10964.725881852699, 11059.502322395672, 11499.195056345976, 11547.614286285363, 11842.230255033395, 10883.401412922365, 11174.832377514507, 11504.36725980079, 11536.192466527262, 11563.19057665989, 9318.201126420036, 9520.95389443596, 9530.761730956781, 9753.707388778348, 9922.503874806374, 9238.30712696564, 9264.212541934012, 9336.346455748033, 9612.903870961201, 9665.178459830993], "value": 5845.855352882604, "unit": "score"}], "name": "dromaeo_css", "value": 6355.67374121983, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 114.0, 107.0, 115.0, 117.0, 113.0, 102.0, 114.0, 112.0, 113.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 130.0, 159.0, 184.0, 135.0, 155.0, 157.0, 133.0, 179.0, 138.0], "value": 153.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 160.0, 160.0, 160.0, 161.0, 160.0, 162.0, 163.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 101.0, 94.0, 76.0, 77.0, 73.0, 123.0, 97.0, 73.0], "value": 86.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 152.0, 94.0, 93.0, 93.0, 138.0, 94.0, 95.0, 134.0], "value": 107.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 66.0, 64.0, 64.0, 65.0, 65.0, 75.0, 63.0, 63.0], "value": 65.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 65.0, 64.0, 64.0, 65.0, 65.0, 65.0, 65.0], "value": 64.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 87.0, 86.0, 93.0, 84.0, 84.0, 84.0, 83.0], "value": 85.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 138.0, 136.0, 138.0, 143.0, 146.0, 137.0, 137.0, 146.0, 139.0], "value": 140.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 180.0, 179.0, 176.0, 176.0, 181.0, 168.0, 170.0, 170.0, 170.0], "value": 175.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 80.0, 71.0, 73.0, 71.0, 73.0, 71.0, 70.0, 71.0, 69.0], "value": 72.1, "unit": "score"}], "name": "kraken", "value": 1580.3999999999999, "alertThreshold": 2.0}]} 22:27:03 INFO - Return code: 0 22:27:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:27:03 ERROR - # TBPL SUCCESS # 22:27:03 INFO - Running post-action listener: _resource_record_post_action 22:27:03 INFO - Running post-run listener: _resource_record_post_run 22:27:04 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 0; Write bytes: 519380992; Read time: 0; Write time: 524712 22:27:04 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 233377792; Read time: 0; Write time: 326860 22:27:04 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 285822976; Read time: 0; Write time: 197828 22:27:04 INFO - Running post-run listener: _upload_blobber_files 22:27:04 INFO - Blob upload gear active. 22:27:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:27:04 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 22:27:04 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'] 22:27:04 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 22:27:05 INFO - (blobuploader) - INFO - Open directory for files ... 22:27:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:27:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:27:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:27:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:27:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:27:05 INFO - (blobuploader) - INFO - Done attempting. 22:27:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:27:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:27:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:27:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:27:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:27:07 INFO - (blobuploader) - INFO - Done attempting. 22:27:07 INFO - (blobuploader) - INFO - Iteration through files over. 22:27:07 INFO - Return code: 0 22:27:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:27:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:27:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3e6e57100a622cc596529babb768e2d6f6d35cf1128f40a6cb70994561ecacdf972e07bb02686bdd7159fbbded6b20b7440c5567e3e37dfb6779e4c956127d56", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cbc6012e70a75d50cef1588af01c441be1fd18edbfcd6c4953cf0499c260c5b25fd18976194f271a774585b3fb8a85bc3f8e22c2168ad4a1d26e32a47a67c081"} 22:27:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:27:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:27:07 INFO - Contents: 22:27:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3e6e57100a622cc596529babb768e2d6f6d35cf1128f40a6cb70994561ecacdf972e07bb02686bdd7159fbbded6b20b7440c5567e3e37dfb6779e4c956127d56", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cbc6012e70a75d50cef1588af01c441be1fd18edbfcd6c4953cf0499c260c5b25fd18976194f271a774585b3fb8a85bc3f8e22c2168ad4a1d26e32a47a67c081"} 22:27:07 INFO - Running post-run listener: copy_logs_to_upload_dir 22:27:07 INFO - Copying logs to upload dir... 22:27:07 INFO - mkdir: /builds/slave/test/build/upload/logs 22:27:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.691885 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-04-08 22:27:06.137662) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-08 22:27:06.141010) ========= 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=82e07478c745e68b1fe4678a000001bc-1460176016.863940-1474057227 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3e6e57100a622cc596529babb768e2d6f6d35cf1128f40a6cb70994561ecacdf972e07bb02686bdd7159fbbded6b20b7440c5567e3e37dfb6779e4c956127d56", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cbc6012e70a75d50cef1588af01c441be1fd18edbfcd6c4953cf0499c260c5b25fd18976194f271a774585b3fb8a85bc3f8e22c2168ad4a1d26e32a47a67c081"} build_url:https://queue.taskcluster.net/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011281 build_url: 'https://queue.taskcluster.net/v1/task/IAnHmmdPRdWFZL2EKhDpkQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3e6e57100a622cc596529babb768e2d6f6d35cf1128f40a6cb70994561ecacdf972e07bb02686bdd7159fbbded6b20b7440c5567e3e37dfb6779e4c956127d56", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cbc6012e70a75d50cef1588af01c441be1fd18edbfcd6c4953cf0499c260c5b25fd18976194f271a774585b3fb8a85bc3f8e22c2168ad4a1d26e32a47a67c081"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-08 22:27:06.165337) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 22:27:06.165635) ========= 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=82e07478c745e68b1fe4678a000001bc-1460176016.863940-1474057227 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004610 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-08 22:27:06.251926) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-08 22:27:06.252239) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-08 22:27:06.252614) ========= ========= Total master_lag: 0.33 =========