builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-046 starttime: 1457531459.08 results: success (0) buildid: 20160309052235 builduid: 08bcc61c798948e09e7e6039d6090b7a revision: ee8f304d9d624328cfd126dd7ed7aa6e35df5b52 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-09 05:50:59.082859) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-09 05:50:59.083324) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-09 05:50:59.083651) ========= 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=652eb03db935cfc1c15ebda0000001ad-1457527862.890856-1945449351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006549 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-09 05:50:59.121128) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-09 05:50:59.121456) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-09 05:50:59.186166) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 05:50:59.186506) ========= 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=652eb03db935cfc1c15ebda0000001ad-1457527862.890856-1945449351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004607 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 05:50:59.247159) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-09 05:50:59.247570) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-09 05:50:59.248020) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 05:50:59.248333) ========= 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=652eb03db935cfc1c15ebda0000001ad-1457527862.890856-1945449351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-09 05:50:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2016-03-09 05:50:59 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.146268 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 05:50:59.407356) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 05:50:59.407672) ========= 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=652eb03db935cfc1c15ebda0000001ad-1457527862.890856-1945449351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020354 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 05:50:59.457752) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-09 05:50:59.458120) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ee8f304d9d624328cfd126dd7ed7aa6e35df5b52 --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 ee8f304d9d624328cfd126dd7ed7aa6e35df5b52 --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=652eb03db935cfc1c15ebda0000001ad-1457527862.890856-1945449351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-09 05:50:59,874 truncating revision to first 12 chars 2016-03-09 05:50:59,874 Setting DEBUG logging. 2016-03-09 05:50:59,874 attempt 1/10 2016-03-09 05:50:59,874 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ee8f304d9d62?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-09 05:51:01,538 unpacking tar archive at: fx-team-ee8f304d9d62/testing/mozharness/ program finished with exit code 0 elapsedTime=1.938094 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-09 05:51:01.409415) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-09 05:51:01.409788) ========= echo ee8f304d9d624328cfd126dd7ed7aa6e35df5b52 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'ee8f304d9d624328cfd126dd7ed7aa6e35df5b52'] 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=652eb03db935cfc1c15ebda0000001ad-1457527862.890856-1945449351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False ee8f304d9d624328cfd126dd7ed7aa6e35df5b52 program finished with exit code 0 elapsedTime=0.004840 script_repo_revision: 'ee8f304d9d624328cfd126dd7ed7aa6e35df5b52' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-09 05:51:01.461227) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-09 05:51:01.461583) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-09 05:51:01.475096) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-03-09 05:51:01.475462) ========= /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=652eb03db935cfc1c15ebda0000001ad-1457527862.890856-1945449351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:51:01 INFO - MultiFileLogger online at 20160309 05:51:01 in /builds/slave/test 05:51:01 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 05:51:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:51:01 INFO - {'append_to_log': False, 05:51:01 INFO - 'base_work_dir': '/builds/slave/test', 05:51:01 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:51:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:51:01 INFO - 'branch': 'Fx-Team-Non-PGO', 05:51:01 INFO - 'buildbot_json_path': 'buildprops.json', 05:51:01 INFO - 'config_files': ('talos/linux_config.py',), 05:51:01 INFO - 'default_actions': ('clobber', 05:51:01 INFO - 'read-buildbot-config', 05:51:01 INFO - 'download-and-extract', 05:51:01 INFO - 'populate-webroot', 05:51:01 INFO - 'create-virtualenv', 05:51:01 INFO - 'install', 05:51:01 INFO - 'run-tests'), 05:51:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:51:01 INFO - 'download_minidump_stackwalk': True, 05:51:01 INFO - 'download_symbols': 'ondemand', 05:51:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:51:01 INFO - 'tooltool.py': '/tools/tooltool.py', 05:51:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:51:01 INFO - '/tools/misc-python/virtualenv.py')}, 05:51:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:51:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:51:01 INFO - 'installer_path': 'installer.exe', 05:51:01 INFO - 'log_level': 'info', 05:51:01 INFO - 'log_name': 'talos', 05:51:01 INFO - 'log_to_console': True, 05:51:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:51:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:51:01 INFO - 'opt_config_files': (), 05:51:01 INFO - 'pip_index': False, 05:51:01 INFO - 'sps_profile': False, 05:51:01 INFO - 'sps_profile_interval': 0, 05:51:01 INFO - 'suite': 'dromaeojs', 05:51:01 INFO - 'system_bits': '32', 05:51:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:51:01 INFO - 'title': 'talos-linux64-ix-046', 05:51:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:51:01 INFO - 'use_talos_json': True, 05:51:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:51:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:51:01 INFO - 'work_dir': 'build'} 05:51:01 INFO - ##### 05:51:01 INFO - ##### Running clobber step. 05:51:01 INFO - ##### 05:51:01 INFO - Running pre-action listener: _resource_record_pre_action 05:51:01 INFO - Running main action method: clobber 05:51:01 INFO - rmtree: /builds/slave/test/build 05:51:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:51:02 INFO - Running post-action listener: _resource_record_post_action 05:51:02 INFO - ##### 05:51:02 INFO - ##### Running read-buildbot-config step. 05:51:02 INFO - ##### 05:51:02 INFO - Running pre-action listener: _resource_record_pre_action 05:51:02 INFO - Running main action method: read_buildbot_config 05:51:02 INFO - Using buildbot properties: 05:51:02 INFO - { 05:51:02 INFO - "project": "", 05:51:02 INFO - "product": "firefox", 05:51:02 INFO - "script_repo_revision": "production", 05:51:02 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:51:02 INFO - "repository": "", 05:51:02 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 05:51:02 INFO - "buildid": "20160309052235", 05:51:02 INFO - "pgo_build": "False", 05:51:02 INFO - "basedir": "/builds/slave/test", 05:51:02 INFO - "buildnumber": 1422, 05:51:02 INFO - "slavename": "talos-linux64-ix-046", 05:51:02 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:51:02 INFO - "platform": "ubuntu64_hw", 05:51:02 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:51:02 INFO - "branch": "fx-team", 05:51:02 INFO - "repo_path": "integration/fx-team", 05:51:02 INFO - "revision": "ee8f304d9d624328cfd126dd7ed7aa6e35df5b52", 05:51:02 INFO - "stage_platform": "linux64", 05:51:02 INFO - "builduid": "08bcc61c798948e09e7e6039d6090b7a", 05:51:02 INFO - "slavebuilddir": "test" 05:51:02 INFO - } 05:51:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/BD3ZawAwRsWScJO1G9NqHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 05:51:02 INFO - Running post-action listener: _resource_record_post_action 05:51:02 INFO - ##### 05:51:02 INFO - ##### Running download-and-extract step. 05:51:02 INFO - ##### 05:51:02 INFO - Running pre-action listener: _resource_record_pre_action 05:51:02 INFO - Running main action method: download_and_extract 05:51:02 INFO - mkdir: /builds/slave/test/build/tests 05:51:02 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')]} 05:51:02 INFO - https://queue.taskcluster.net/v1/task/BD3ZawAwRsWScJO1G9NqHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:51:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BD3ZawAwRsWScJO1G9NqHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:51:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BD3ZawAwRsWScJO1G9NqHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:51:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BD3ZawAwRsWScJO1G9NqHA/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 05:51:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BD3ZawAwRsWScJO1G9NqHA/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 05:51:03 INFO - Downloaded 1361 bytes. 05:51:03 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:51:03 INFO - Using the following test package requirements: 05:51:03 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:51:03 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:51:03 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:51:03 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:51:03 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:51:03 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:51:03 INFO - u'jsshell-linux-x86_64.zip'], 05:51:03 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:51:03 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:51:03 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:51:03 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:51:03 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:51:03 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:51:03 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:51:03 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:51:03 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:51:03 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:51:03 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:51:03 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:51: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')]} 05:51:03 INFO - https://queue.taskcluster.net/v1/task/BD3ZawAwRsWScJO1G9NqHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:51:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BD3ZawAwRsWScJO1G9NqHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:51:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BD3ZawAwRsWScJO1G9NqHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:51:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BD3ZawAwRsWScJO1G9NqHA/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 05:51:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BD3ZawAwRsWScJO1G9NqHA/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 05:51:04 INFO - Downloaded 22091650 bytes. 05:51:04 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'] 05:51:04 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 05:51:05 INFO - Return code: 0 05:51:05 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 05:51:05 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')]} 05:51:05 INFO - https://queue.taskcluster.net/v1/task/BD3ZawAwRsWScJO1G9NqHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:51:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BD3ZawAwRsWScJO1G9NqHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:51:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BD3ZawAwRsWScJO1G9NqHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:51:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BD3ZawAwRsWScJO1G9NqHA/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 05:51:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BD3ZawAwRsWScJO1G9NqHA/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 05:51:06 INFO - Downloaded 22091650 bytes. 05:51:06 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'] 05:51:06 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 05:51:07 INFO - Return code: 0 05:51:07 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')]} 05:51:07 INFO - https://queue.taskcluster.net/v1/task/BD3ZawAwRsWScJO1G9NqHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:51:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BD3ZawAwRsWScJO1G9NqHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:51:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BD3ZawAwRsWScJO1G9NqHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:51:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BD3ZawAwRsWScJO1G9NqHA/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 05:51:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BD3ZawAwRsWScJO1G9NqHA/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 05:51:09 INFO - Downloaded 10845161 bytes. 05:51:09 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'] 05:51:09 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 05:51:09 INFO - Return code: 0 05:51:09 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')]} 05:51:09 INFO - https://queue.taskcluster.net/v1/task/BD3ZawAwRsWScJO1G9NqHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:51:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BD3ZawAwRsWScJO1G9NqHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:51:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BD3ZawAwRsWScJO1G9NqHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:51:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BD3ZawAwRsWScJO1G9NqHA/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 05:51:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BD3ZawAwRsWScJO1G9NqHA/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 05:51:12 INFO - Downloaded 54417937 bytes. 05:51:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BD3ZawAwRsWScJO1G9NqHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:51:12 INFO - mkdir: /builds/slave/test/properties 05:51:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:51:12 INFO - Writing to file /builds/slave/test/properties/build_url 05:51:12 INFO - Contents: 05:51:12 INFO - build_url:https://queue.taskcluster.net/v1/task/BD3ZawAwRsWScJO1G9NqHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:51:13 INFO - Running post-action listener: _resource_record_post_action 05:51:13 INFO - Running post-action listener: set_extra_try_arguments 05:51:13 INFO - ##### 05:51:13 INFO - ##### Running populate-webroot step. 05:51:13 INFO - ##### 05:51:13 INFO - Running pre-action listener: _resource_record_pre_action 05:51:13 INFO - Running main action method: populate_webroot 05:51:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:51:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:51:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:51:13 INFO - '--tppagecycles', 05:51:13 INFO - '7'], 05:51:13 INFO - 'tests': ['tsvgm']}}, 05:51:13 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:51:13 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:51:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:51:13 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:51:13 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:51:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:51:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:51:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:13 INFO - 'talos_options': ['--e10s'], 05:51:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:51:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:13 INFO - 'tests': ['damp', 'tps']}, 05:51:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:13 INFO - 'talos_options': ['--e10s'], 05:51:13 INFO - 'tests': ['damp', 'tps']}, 05:51:13 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:51:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:51:13 INFO - 'other': {'tests': ['a11yr', 05:51:13 INFO - 'ts_paint', 05:51:13 INFO - 'tpaint', 05:51:13 INFO - 'sessionrestore', 05:51:13 INFO - 'sessionrestore_no_auto_restore', 05:51:13 INFO - 'tabpaint']}, 05:51:13 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:51:13 INFO - 'tests': ['a11yr', 05:51:13 INFO - 'ts_paint', 05:51:13 INFO - 'tpaint', 05:51:13 INFO - 'sessionrestore', 05:51:13 INFO - 'sessionrestore_no_auto_restore', 05:51:13 INFO - 'tabpaint']}, 05:51:13 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:51:13 INFO - 'tests': ['a11yr', 05:51:13 INFO - 'ts_paint', 05:51:13 INFO - 'tpaint', 05:51:13 INFO - 'sessionrestore', 05:51:13 INFO - 'sessionrestore_no_auto_restore', 05:51:13 INFO - 'tabpaint']}, 05:51:13 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:51:13 INFO - 'tests': ['a11yr', 05:51:13 INFO - 'ts_paint', 05:51:13 INFO - 'tpaint', 05:51:13 INFO - 'sessionrestore', 05:51:13 INFO - 'sessionrestore_no_auto_restore', 05:51:13 INFO - 'tabpaint']}, 05:51:13 INFO - 'other_l64': {'tests': ['a11yr', 05:51:13 INFO - 'ts_paint', 05:51:13 INFO - 'tpaint', 05:51:13 INFO - 'sessionrestore', 05:51:13 INFO - 'sessionrestore_no_auto_restore', 05:51:13 INFO - 'tabpaint']}, 05:51:13 INFO - 'other_nol64': {'tests': ['a11yr', 05:51:13 INFO - 'ts_paint', 05:51:13 INFO - 'tpaint', 05:51:13 INFO - 'sessionrestore', 05:51:13 INFO - 'sessionrestore_no_auto_restore', 05:51:13 INFO - 'tabpaint']}, 05:51:13 INFO - 'svgr': {'tests': ['tsvgx', 05:51:13 INFO - 'tsvgr_opacity', 05:51:13 INFO - 'tart', 05:51:13 INFO - 'tscrollx', 05:51:13 INFO - 'cart']}, 05:51:13 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:51:13 INFO - 'tests': ['tsvgx', 05:51:13 INFO - 'tsvgr_opacity', 05:51:13 INFO - 'tart', 05:51:13 INFO - 'tscrollx', 05:51:13 INFO - 'cart']}, 05:51:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:13 INFO - 'tests': ['tp5o']}, 05:51:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:13 INFO - 'talos_options': ['--e10s'], 05:51:13 INFO - 'tests': ['tp5o']}, 05:51:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:13 INFO - 'talos_options': ['--xperf_path', 05:51:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:51:13 INFO - 'tests': ['tp5n']}, 05:51:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:51:13 INFO - 'talos_options': ['--e10s', 05:51:13 INFO - '--xperf_path', 05:51:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:51:13 INFO - 'tests': ['tp5n']}}, 05:51:13 INFO - 'talos.zip': {'path': '', 05:51:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:51:13 INFO - Running post-action listener: _resource_record_post_action 05:51:13 INFO - ##### 05:51:13 INFO - ##### Running create-virtualenv step. 05:51:13 INFO - ##### 05:51:13 INFO - Running pre-action listener: _resource_record_pre_action 05:51:13 INFO - Running main action method: create_virtualenv 05:51:13 INFO - Creating virtualenv /builds/slave/test/build/venv 05:51:13 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 05:51:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:51:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:51:13 INFO - Using real prefix '/usr' 05:51:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:51:13 INFO - Installing distribute.............................................................................................................................................................................................done. 05:51:15 INFO - Installing pip.................done. 05:51:15 INFO - Return code: 0 05:51:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:51: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')]} 05:51:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51: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')]} 05:51:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:15 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 0x7f8418a92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fae410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203d160>, '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 0x203e060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203e4f0>, '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': '652eb03db935cfc1c15ebda0000001ad-1457527862.890856-1945449351', '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 05:51:15 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 05:51:15 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 05:51:15 INFO - Using env: {'DISPLAY': ':0', 05:51:15 INFO - 'HOME': '/home/cltbld', 05:51:15 INFO - 'LANG': 'en_US.UTF-8', 05:51:15 INFO - 'LANGUAGE': 'en_US:en', 05:51:15 INFO - 'LOGNAME': 'cltbld', 05:51:15 INFO - 'MAIL': '/var/mail/cltbld', 05:51:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:15 INFO - 'MOZ_NO_REMOTE': '1', 05:51:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:15 INFO - 'NO_EM_RESTART': '1', 05:51:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:15 INFO - 'PWD': '/builds/slave/test', 05:51:15 INFO - 'SHELL': '/bin/bash', 05:51:15 INFO - 'SHLVL': '1', 05:51:15 INFO - 'TERM': 'linux', 05:51:15 INFO - 'TMOUT': '86400', 05:51:15 INFO - 'USER': 'cltbld', 05:51:15 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1457527862.890856-1945449351', 05:51:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:15 INFO - '_': '/tools/buildbot/bin/python'} 05:51:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:15 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 05:51:15 INFO - Cleaning up... 05:51:15 INFO - Return code: 0 05:51:15 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:51: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')]} 05:51:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51: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')]} 05:51:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:15 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 0x7f8418a92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fae410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203d160>, '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 0x203e060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203e4f0>, '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': '652eb03db935cfc1c15ebda0000001ad-1457527862.890856-1945449351', '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 05:51:15 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 05:51:15 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 05:51:15 INFO - Using env: {'DISPLAY': ':0', 05:51:15 INFO - 'HOME': '/home/cltbld', 05:51:15 INFO - 'LANG': 'en_US.UTF-8', 05:51:15 INFO - 'LANGUAGE': 'en_US:en', 05:51:15 INFO - 'LOGNAME': 'cltbld', 05:51:15 INFO - 'MAIL': '/var/mail/cltbld', 05:51:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:15 INFO - 'MOZ_NO_REMOTE': '1', 05:51:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:15 INFO - 'NO_EM_RESTART': '1', 05:51:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:15 INFO - 'PWD': '/builds/slave/test', 05:51:15 INFO - 'SHELL': '/bin/bash', 05:51:15 INFO - 'SHLVL': '1', 05:51:15 INFO - 'TERM': 'linux', 05:51:15 INFO - 'TMOUT': '86400', 05:51:15 INFO - 'USER': 'cltbld', 05:51:15 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1457527862.890856-1945449351', 05:51:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:15 INFO - '_': '/tools/buildbot/bin/python'} 05:51:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:16 INFO - Downloading/unpacking psutil>=0.7.1 05:51:16 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 05:51:16 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 05:51:16 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 05:51:16 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 05:51:16 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 05:51:16 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 05:51:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:51:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:51:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:51:18 INFO - Installing collected packages: psutil 05:51:18 INFO - Running setup.py install for psutil 05:51:18 INFO - building 'psutil._psutil_linux' extension 05:51:18 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 05:51:18 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 05:51:18 INFO - building 'psutil._psutil_posix' extension 05:51:18 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 05:51:18 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 05:51:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:51:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:51:18 INFO - Successfully installed psutil 05:51:18 INFO - Cleaning up... 05:51:18 INFO - Return code: 0 05:51:18 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:51:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:18 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 0x7f8418a92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fae410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203d160>, '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 0x203e060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203e4f0>, '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': '652eb03db935cfc1c15ebda0000001ad-1457527862.890856-1945449351', '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 05:51:18 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 05:51:18 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 05:51:18 INFO - Using env: {'DISPLAY': ':0', 05:51:18 INFO - 'HOME': '/home/cltbld', 05:51:18 INFO - 'LANG': 'en_US.UTF-8', 05:51:18 INFO - 'LANGUAGE': 'en_US:en', 05:51:18 INFO - 'LOGNAME': 'cltbld', 05:51:18 INFO - 'MAIL': '/var/mail/cltbld', 05:51:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:18 INFO - 'MOZ_NO_REMOTE': '1', 05:51:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:18 INFO - 'NO_EM_RESTART': '1', 05:51:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:18 INFO - 'PWD': '/builds/slave/test', 05:51:18 INFO - 'SHELL': '/bin/bash', 05:51:18 INFO - 'SHLVL': '1', 05:51:18 INFO - 'TERM': 'linux', 05:51:18 INFO - 'TMOUT': '86400', 05:51:18 INFO - 'USER': 'cltbld', 05:51:18 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1457527862.890856-1945449351', 05:51:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:18 INFO - '_': '/tools/buildbot/bin/python'} 05:51:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:18 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:51:18 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 05:51:18 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 05:51:18 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 05:51:18 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 05:51:18 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 05:51:18 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 05:51:20 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:51:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:51:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:51:20 INFO - Installing collected packages: mozsystemmonitor 05:51:20 INFO - Running setup.py install for mozsystemmonitor 05:51:20 INFO - Successfully installed mozsystemmonitor 05:51:20 INFO - Cleaning up... 05:51:20 INFO - Return code: 0 05:51:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:51:20 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')]} 05:51:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:20 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')]} 05:51:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:20 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 0x7f8418a92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fae410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203d160>, '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 0x203e060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203e4f0>, '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': '652eb03db935cfc1c15ebda0000001ad-1457527862.890856-1945449351', '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 05:51:20 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 05:51:20 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 05:51:20 INFO - Using env: {'DISPLAY': ':0', 05:51:20 INFO - 'HOME': '/home/cltbld', 05:51:20 INFO - 'LANG': 'en_US.UTF-8', 05:51:20 INFO - 'LANGUAGE': 'en_US:en', 05:51:20 INFO - 'LOGNAME': 'cltbld', 05:51:20 INFO - 'MAIL': '/var/mail/cltbld', 05:51:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:20 INFO - 'MOZ_NO_REMOTE': '1', 05:51:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:20 INFO - 'NO_EM_RESTART': '1', 05:51:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:20 INFO - 'PWD': '/builds/slave/test', 05:51:20 INFO - 'SHELL': '/bin/bash', 05:51:20 INFO - 'SHLVL': '1', 05:51:20 INFO - 'TERM': 'linux', 05:51:20 INFO - 'TMOUT': '86400', 05:51:20 INFO - 'USER': 'cltbld', 05:51:20 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1457527862.890856-1945449351', 05:51:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:20 INFO - '_': '/tools/buildbot/bin/python'} 05:51:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:21 INFO - Downloading/unpacking blobuploader==1.2.4 05:51:21 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 05:51:21 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 05:51:21 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 05:51:21 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 05:51:21 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 05:51:21 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 05:51:23 INFO - Downloading blobuploader-1.2.4.tar.gz 05:51:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:51:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:51:23 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 05:51:23 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 05:51:23 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 05:51:23 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 05:51:23 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 05:51:23 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 05:51:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:51:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:51:23 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 05:51:23 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 05:51:23 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 05:51:23 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 05:51:23 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 05:51:23 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 05:51:23 INFO - Downloading docopt-0.6.1.tar.gz 05:51:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:51:23 INFO - Installing collected packages: blobuploader, requests, docopt 05:51:23 INFO - Running setup.py install for blobuploader 05:51:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:51:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:51:23 INFO - Running setup.py install for requests 05:51:24 INFO - Running setup.py install for docopt 05:51:24 INFO - Successfully installed blobuploader requests docopt 05:51:24 INFO - Cleaning up... 05:51:24 INFO - Return code: 0 05:51:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:51:24 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')]} 05:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:24 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')]} 05:51:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:24 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 0x7f8418a92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fae410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203d160>, '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 0x203e060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203e4f0>, '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': '652eb03db935cfc1c15ebda0000001ad-1457527862.890856-1945449351', '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 05:51:24 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 05:51:24 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 05:51:24 INFO - Using env: {'DISPLAY': ':0', 05:51:24 INFO - 'HOME': '/home/cltbld', 05:51:24 INFO - 'LANG': 'en_US.UTF-8', 05:51:24 INFO - 'LANGUAGE': 'en_US:en', 05:51:24 INFO - 'LOGNAME': 'cltbld', 05:51:24 INFO - 'MAIL': '/var/mail/cltbld', 05:51:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:24 INFO - 'MOZ_NO_REMOTE': '1', 05:51:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:24 INFO - 'NO_EM_RESTART': '1', 05:51:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:24 INFO - 'PWD': '/builds/slave/test', 05:51:24 INFO - 'SHELL': '/bin/bash', 05:51:24 INFO - 'SHLVL': '1', 05:51:24 INFO - 'TERM': 'linux', 05:51:24 INFO - 'TMOUT': '86400', 05:51:24 INFO - 'USER': 'cltbld', 05:51:24 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1457527862.890856-1945449351', 05:51:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:24 INFO - '_': '/tools/buildbot/bin/python'} 05:51:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:51:24 INFO - Running setup.py (path:/tmp/pip-TGh6N3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:51:24 INFO - Running setup.py (path:/tmp/pip-PTNYfZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:51:24 INFO - Running setup.py (path:/tmp/pip-Jk_sjy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:51:24 INFO - Running setup.py (path:/tmp/pip-CCUx8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:51:24 INFO - Running setup.py (path:/tmp/pip-eK1U5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:51:25 INFO - Running setup.py (path:/tmp/pip-7sodNf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:51:25 INFO - Running setup.py (path:/tmp/pip-JKlyL4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:51:25 INFO - Running setup.py (path:/tmp/pip-3IPAhx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:51:25 INFO - Running setup.py (path:/tmp/pip-gUjWmr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:51:25 INFO - Running setup.py (path:/tmp/pip-jbT_4C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:51:25 INFO - Running setup.py (path:/tmp/pip-NPcmMC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:51:25 INFO - Running setup.py (path:/tmp/pip-UO0m8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:51:25 INFO - Running setup.py (path:/tmp/pip-1qg8oU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:51:25 INFO - Running setup.py (path:/tmp/pip-3mmlq4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:51:25 INFO - Running setup.py (path:/tmp/pip-G2783v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:51:25 INFO - Running setup.py (path:/tmp/pip-sfyWC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:51:25 INFO - Running setup.py (path:/tmp/pip-vN4RGo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:51:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:51:25 INFO - Running setup.py install for manifestparser 05:51:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:51:25 INFO - Running setup.py install for mozcrash 05:51:26 INFO - Running setup.py install for mozdebug 05:51:26 INFO - Running setup.py install for mozdevice 05:51:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:51:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:51:26 INFO - Running setup.py install for mozfile 05:51:26 INFO - Running setup.py install for mozhttpd 05:51:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:51:26 INFO - Running setup.py install for mozinfo 05:51:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:51:26 INFO - Running setup.py install for mozInstall 05:51:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:51:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:51:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:51:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:51:26 INFO - Running setup.py install for mozleak 05:51:26 INFO - Running setup.py install for mozlog 05:51:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:51:26 INFO - Running setup.py install for moznetwork 05:51:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:51:27 INFO - Running setup.py install for mozprocess 05:51:27 INFO - Running setup.py install for mozprofile 05:51:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:51:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:51:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:51:27 INFO - Running setup.py install for mozrunner 05:51:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:51:27 INFO - Running setup.py install for mozscreenshot 05:51:27 INFO - Running setup.py install for moztest 05:51:27 INFO - Running setup.py install for mozversion 05:51:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:51:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:51:27 INFO - Cleaning up... 05:51:27 INFO - Return code: 0 05:51:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:51:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:51:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:27 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 0x7f8418a92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fae410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203d160>, '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 0x203e060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203e4f0>, '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': '652eb03db935cfc1c15ebda0000001ad-1457527862.890856-1945449351', '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 05:51:27 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 05:51:27 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 05:51:27 INFO - Using env: {'DISPLAY': ':0', 05:51:27 INFO - 'HOME': '/home/cltbld', 05:51:27 INFO - 'LANG': 'en_US.UTF-8', 05:51:27 INFO - 'LANGUAGE': 'en_US:en', 05:51:27 INFO - 'LOGNAME': 'cltbld', 05:51:27 INFO - 'MAIL': '/var/mail/cltbld', 05:51:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:27 INFO - 'MOZ_NO_REMOTE': '1', 05:51:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:27 INFO - 'NO_EM_RESTART': '1', 05:51:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:27 INFO - 'PWD': '/builds/slave/test', 05:51:27 INFO - 'SHELL': '/bin/bash', 05:51:27 INFO - 'SHLVL': '1', 05:51:27 INFO - 'TERM': 'linux', 05:51:27 INFO - 'TMOUT': '86400', 05:51:27 INFO - 'USER': 'cltbld', 05:51:27 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1457527862.890856-1945449351', 05:51:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:27 INFO - '_': '/tools/buildbot/bin/python'} 05:51:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:51:27 INFO - Running setup.py (path:/tmp/pip-LiUXOm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:51:27 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)) 05:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:51:27 INFO - Running setup.py (path:/tmp/pip-0kKwIZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:51:28 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)) 05:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:51:28 INFO - Running setup.py (path:/tmp/pip-pMRreK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:51:28 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)) 05:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:51:28 INFO - Running setup.py (path:/tmp/pip-lOnoag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:51:28 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)) 05:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:51:28 INFO - Running setup.py (path:/tmp/pip-GzA_MZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:51:28 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)) 05:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:51:28 INFO - Running setup.py (path:/tmp/pip-NYOXbS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:51:28 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)) 05:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:51:28 INFO - Running setup.py (path:/tmp/pip-q4UTKP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:51:28 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)) 05:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:51:28 INFO - Running setup.py (path:/tmp/pip-o4iTE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:51:28 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)) 05:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:51:28 INFO - Running setup.py (path:/tmp/pip-IqFqLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:51:28 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)) 05:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:51:28 INFO - Running setup.py (path:/tmp/pip-GtI7lE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:51:28 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)) 05:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:51:28 INFO - Running setup.py (path:/tmp/pip-FTfkff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:51:28 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)) 05:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:51:28 INFO - Running setup.py (path:/tmp/pip-4wv8mO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:51:28 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)) 05:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:51:28 INFO - Running setup.py (path:/tmp/pip-heKcIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:51:28 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)) 05:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:51:28 INFO - Running setup.py (path:/tmp/pip-sFLHly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:51:28 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)) 05:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:51:28 INFO - Running setup.py (path:/tmp/pip-d4iNqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:51:28 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)) 05:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:51:28 INFO - Running setup.py (path:/tmp/pip-MZ_8nF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:51:29 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)) 05:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:51:29 INFO - Running setup.py (path:/tmp/pip-n0HPQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:51:29 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)) 05:51:29 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)) 05:51:29 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)) 05:51:29 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)) 05:51:29 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)) 05:51:29 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)) 05:51:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:51:29 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 05:51:29 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 05:51:29 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 05:51:29 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 05:51:29 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 05:51:29 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 05:51:30 INFO - Downloading blessings-1.6.tar.gz 05:51:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:51:31 INFO - Installing collected packages: blessings 05:51:31 INFO - Running setup.py install for blessings 05:51:31 INFO - Successfully installed blessings 05:51:31 INFO - Cleaning up... 05:51:31 INFO - Return code: 0 05:51:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:51:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:51:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:51:31 INFO - Reading from file tmpfile_stdout 05:51:31 INFO - Current package versions: 05:51:31 INFO - argparse == 1.2.1 05:51:31 INFO - blessings == 1.6 05:51:31 INFO - blobuploader == 1.2.4 05:51:31 INFO - docopt == 0.6.1 05:51:31 INFO - manifestparser == 1.1 05:51:31 INFO - mozInstall == 1.12 05:51:31 INFO - mozcrash == 0.17 05:51:31 INFO - mozdebug == 0.1 05:51:31 INFO - mozdevice == 0.48 05:51:31 INFO - mozfile == 1.2 05:51:31 INFO - mozhttpd == 0.7 05:51:31 INFO - mozinfo == 0.9 05:51:31 INFO - mozleak == 0.1 05:51:31 INFO - mozlog == 3.1 05:51:31 INFO - moznetwork == 0.27 05:51:31 INFO - mozprocess == 0.22 05:51:31 INFO - mozprofile == 0.28 05:51:31 INFO - mozrunner == 6.11 05:51:31 INFO - mozscreenshot == 0.1 05:51:31 INFO - mozsystemmonitor == 0.0 05:51:31 INFO - moztest == 0.7 05:51:31 INFO - mozversion == 1.4 05:51:31 INFO - psutil == 3.1.1 05:51:31 INFO - requests == 1.2.3 05:51:31 INFO - wsgiref == 0.1.2 05:51:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:51:31 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')]} 05:51:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:31 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')]} 05:51:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:31 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 0x7f8418a92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fae410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203d160>, '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 0x203e060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203e4f0>, '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': '652eb03db935cfc1c15ebda0000001ad-1457527862.890856-1945449351', '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 05:51:31 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 05:51:31 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 05:51:31 INFO - Using env: {'DISPLAY': ':0', 05:51:31 INFO - 'HOME': '/home/cltbld', 05:51:31 INFO - 'LANG': 'en_US.UTF-8', 05:51:31 INFO - 'LANGUAGE': 'en_US:en', 05:51:31 INFO - 'LOGNAME': 'cltbld', 05:51:31 INFO - 'MAIL': '/var/mail/cltbld', 05:51:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:31 INFO - 'MOZ_NO_REMOTE': '1', 05:51:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:31 INFO - 'NO_EM_RESTART': '1', 05:51:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:31 INFO - 'PWD': '/builds/slave/test', 05:51:31 INFO - 'SHELL': '/bin/bash', 05:51:31 INFO - 'SHLVL': '1', 05:51:31 INFO - 'TERM': 'linux', 05:51:31 INFO - 'TMOUT': '86400', 05:51:31 INFO - 'USER': 'cltbld', 05:51:31 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1457527862.890856-1945449351', 05:51:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:31 INFO - '_': '/tools/buildbot/bin/python'} 05:51:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:31 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)) 05:51:31 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)) 05:51:31 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)) 05:51:31 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)) 05:51:31 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)) 05:51:31 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)) 05:51:31 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)) 05:51:31 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)) 05:51:31 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)) 05:51:31 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)) 05:51:31 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)) 05:51:31 INFO - Cleaning up... 05:51:31 INFO - Return code: 0 05:51:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:51:31 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')]} 05:51:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:31 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')]} 05:51:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:31 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 0x7f8418a92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fae410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203d160>, '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 0x203e060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203e4f0>, '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': '652eb03db935cfc1c15ebda0000001ad-1457527862.890856-1945449351', '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 05:51:31 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 05:51:31 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 05:51:31 INFO - Using env: {'DISPLAY': ':0', 05:51:31 INFO - 'HOME': '/home/cltbld', 05:51:31 INFO - 'LANG': 'en_US.UTF-8', 05:51:31 INFO - 'LANGUAGE': 'en_US:en', 05:51:31 INFO - 'LOGNAME': 'cltbld', 05:51:31 INFO - 'MAIL': '/var/mail/cltbld', 05:51:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:31 INFO - 'MOZ_NO_REMOTE': '1', 05:51:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:31 INFO - 'NO_EM_RESTART': '1', 05:51:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:31 INFO - 'PWD': '/builds/slave/test', 05:51:31 INFO - 'SHELL': '/bin/bash', 05:51:31 INFO - 'SHLVL': '1', 05:51:31 INFO - 'TERM': 'linux', 05:51:31 INFO - 'TMOUT': '86400', 05:51:31 INFO - 'USER': 'cltbld', 05:51:31 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1457527862.890856-1945449351', 05:51:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:31 INFO - '_': '/tools/buildbot/bin/python'} 05:51:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:31 INFO - Downloading/unpacking jsonschema 05:51:31 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 05:51:31 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 05:51:31 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 05:51:31 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 05:51:31 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 05:51:31 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 05:51:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:51:33 INFO - Downloading/unpacking functools32 (from jsonschema) 05:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:33 INFO - Downloading functools32-3.2.3-2.tar.gz 05:51:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:51:33 INFO - warning: no files found matching '*.txt' 05:51:33 INFO - no previously-included directories found matching 'build' 05:51:33 INFO - no previously-included directories found matching 'dist' 05:51:33 INFO - no previously-included directories found matching '.git*' 05:51:33 INFO - Installing collected packages: jsonschema, functools32 05:51:33 INFO - Running setup.py install for functools32 05:51:34 INFO - warning: no files found matching '*.txt' 05:51:34 INFO - no previously-included directories found matching 'build' 05:51:34 INFO - no previously-included directories found matching 'dist' 05:51:34 INFO - no previously-included directories found matching '.git*' 05:51:34 INFO - Successfully installed jsonschema functools32 05:51:34 INFO - Cleaning up... 05:51:34 INFO - Return code: 0 05:51:34 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:51:34 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')]} 05:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:51:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:34 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')]} 05:51:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:51:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:51:34 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 0x7f8418a92f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fae410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203d160>, '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 0x203e060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203e4f0>, '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': '652eb03db935cfc1c15ebda0000001ad-1457527862.890856-1945449351', '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 05:51:34 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 05:51:34 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 05:51:34 INFO - Using env: {'DISPLAY': ':0', 05:51:34 INFO - 'HOME': '/home/cltbld', 05:51:34 INFO - 'LANG': 'en_US.UTF-8', 05:51:34 INFO - 'LANGUAGE': 'en_US:en', 05:51:34 INFO - 'LOGNAME': 'cltbld', 05:51:34 INFO - 'MAIL': '/var/mail/cltbld', 05:51:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:34 INFO - 'MOZ_NO_REMOTE': '1', 05:51:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:34 INFO - 'NO_EM_RESTART': '1', 05:51:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:34 INFO - 'PWD': '/builds/slave/test', 05:51:34 INFO - 'SHELL': '/bin/bash', 05:51:34 INFO - 'SHLVL': '1', 05:51:34 INFO - 'TERM': 'linux', 05:51:34 INFO - 'TMOUT': '86400', 05:51:34 INFO - 'USER': 'cltbld', 05:51:34 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1457527862.890856-1945449351', 05:51:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:34 INFO - '_': '/tools/buildbot/bin/python'} 05:51:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:51:34 INFO - Downloading/unpacking flake8 05:51:34 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 05:51:34 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 05:51:34 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 05:51:34 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 05:51:34 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 05:51:34 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 05:51:36 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:51:36 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:51:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:36 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:51:36 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:51:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:36 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:51:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:51:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:51:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:51:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:51:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:51:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:51:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:51:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:51:36 INFO - no previously-included directories found matching 'docs/_build' 05:51:36 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:51:36 INFO - Running setup.py install for pep8 05:51:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:51:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:51:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:51:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:51:37 INFO - no previously-included directories found matching 'docs/_build' 05:51:37 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:51:37 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:51:37 INFO - Cleaning up... 05:51:37 INFO - Return code: 0 05:51:37 INFO - Running post-action listener: _resource_record_post_action 05:51:37 INFO - Running post-action listener: _start_resource_monitoring 05:51:37 INFO - Starting resource monitoring. 05:51:37 INFO - ##### 05:51:37 INFO - ##### Running install step. 05:51:37 INFO - ##### 05:51:37 INFO - Running pre-action listener: _resource_record_pre_action 05:51:37 INFO - Running main action method: install 05:51:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:51:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:51:37 INFO - Reading from file tmpfile_stdout 05:51:37 INFO - Detecting whether we're running mozinstall >=1.0... 05:51:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:51:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:51:37 INFO - Reading from file tmpfile_stdout 05:51:37 INFO - Output received: 05:51:37 INFO - Usage: mozinstall [options] installer 05:51:37 INFO - Options: 05:51:37 INFO - -h, --help show this help message and exit 05:51:37 INFO - -d DEST, --destination=DEST 05:51:37 INFO - Directory to install application into. [default: 05:51:37 INFO - "/builds/slave/test"] 05:51:37 INFO - --app=APP Application being installed. [default: firefox] 05:51:37 INFO - mkdir: /builds/slave/test/build/application 05:51:37 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'] 05:51:37 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 05:51:53 INFO - Reading from file tmpfile_stdout 05:51:53 INFO - Output received: 05:51:53 INFO - /builds/slave/test/build/application/firefox/firefox 05:51:53 INFO - Running post-action listener: _resource_record_post_action 05:51:53 INFO - ##### 05:51:53 INFO - ##### Running run-tests step. 05:51:53 INFO - ##### 05:51:53 INFO - Running pre-action listener: _resource_record_pre_action 05:51:53 INFO - Running main action method: run_tests 05:51:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:51:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:51:53 INFO - Python 2.7.3 05:51:53 INFO - Return code: 0 05:51:53 INFO - grabbing minidump binary from tooltool 05:51: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')]} 05:51:53 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 0x203d160>, '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 0x203e060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x203e4f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:51:53 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 05:51:53 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 05:51:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:51:53 INFO - Return code: 0 05:51:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:51:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:51:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:51:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:51:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:51:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:51:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:51:54 INFO - Return code: 0 05:51:54 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/BD3ZawAwRsWScJO1G9NqHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 05:51:54 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/BD3ZawAwRsWScJO1G9NqHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --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 05:51:54 INFO - Using env: {'DISPLAY': ':0', 05:51:54 INFO - 'HOME': '/home/cltbld', 05:51:54 INFO - 'LANG': 'en_US.UTF-8', 05:51:54 INFO - 'LANGUAGE': 'en_US:en', 05:51:54 INFO - 'LOGNAME': 'cltbld', 05:51:54 INFO - 'MAIL': '/var/mail/cltbld', 05:51:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:51:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:51:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:54 INFO - 'MOZ_NO_REMOTE': '1', 05:51:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:51:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:51:54 INFO - 'NO_EM_RESTART': '1', 05:51:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:51:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:54 INFO - 'PWD': '/builds/slave/test', 05:51:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:51:54 INFO - 'SHELL': '/bin/bash', 05:51:54 INFO - 'SHLVL': '1', 05:51:54 INFO - 'TERM': 'linux', 05:51:54 INFO - 'TMOUT': '86400', 05:51:54 INFO - 'USER': 'cltbld', 05:51:54 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1457527862.890856-1945449351', 05:51:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:54 INFO - '_': '/tools/buildbot/bin/python'} 05:51:54 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/BD3ZawAwRsWScJO1G9NqHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 05:51:54 INFO - mozversion application_buildid: 20160309052235 05:51:54 INFO - mozversion application_changeset: ee8f304d9d624328cfd126dd7ed7aa6e35df5b52 05:51:54 INFO - mozversion application_display_name: Nightly 05:51:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:51:54 INFO - mozversion application_name: Firefox 05:51:54 INFO - mozversion application_remotingname: firefox 05:51:54 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:51:54 INFO - mozversion application_vendor: Mozilla 05:51:54 INFO - mozversion application_version: 48.0a1 05:51:54 INFO - mozversion platform_buildid: 20160309052235 05:51:54 INFO - mozversion platform_changeset: ee8f304d9d624328cfd126dd7ed7aa6e35df5b52 05:51:54 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:51:54 INFO - mozversion platform_version: 48.0a1 05:51:54 INFO - using testdate: 1457531514 05:51:54 INFO - actual date: 1457531514 05:51:54 INFO - starting webserver on 'localhost:46183' 05:51:54 INFO - SUITE-START | Running 2 tests 05:51:54 INFO - TEST-START | dromaeo_css 05:51:54 INFO - operating with platform_type : linux_ 05:51:54 INFO - Initialising browser for dromaeo_css test... 05:51:54 INFO - TEST-INFO | started process 4096 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwDr6nE/profile http://localhost:46183/getInfo.html) 05:51:58 INFO - PROCESS | 4096 | __metrics Screen width/height:1600/1200 05:51:58 INFO - PROCESS | 4096 | colorDepth:24 05:51:58 INFO - PROCESS | 4096 | Browser inner width/height: 1024/697 05:51:58 INFO - PROCESS | 4096 | __metrics 05:51:59 ERROR - PROCESS | 4096 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:51:59 INFO - PROCESS | 4096 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 05:52:00 INFO - TEST-INFO | 4096: exit 0 05:52:00 INFO - Browser initialized. 05:52:00 INFO - Running cycle 1/1 for dromaeo_css test... 05:52:00 INFO - TEST-INFO | started process 4191 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwDr6nE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:52:12 INFO - PROCESS | 4191 | RSS: Main: 153915392 05:52:12 INFO - PROCESS | 4191 | 05:53:03 INFO - PROCESS | 4191 | 1457531583789 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] 05:55:15 INFO - PROCESS | 4191 | Cycle 1(1): loaded http://localhost:46183/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46183/tests/dromaeo/cssquery-ext.html) 05:55:16 INFO - PROCESS | 4191 | RSS: Main: 246616064 05:55:16 INFO - PROCESS | 4191 | 05:58:18 INFO - PROCESS | 4191 | Cycle 1(1): loaded http://localhost:46183/tests/dromaeo/cssquery-ext.html (next: http://localhost:46183/tests/dromaeo/cssquery-jquery.html) 05:58:18 INFO - PROCESS | 4191 | RSS: Main: 241766400 05:58:18 INFO - PROCESS | 4191 | 06:01:20 INFO - PROCESS | 4191 | Cycle 1(1): loaded http://localhost:46183/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46183/tests/dromaeo/cssquery-mootools.html) 06:01:21 INFO - PROCESS | 4191 | RSS: Main: 231149568 06:01:21 INFO - PROCESS | 4191 | 06:04:23 INFO - PROCESS | 4191 | Cycle 1(1): loaded http://localhost:46183/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46183/tests/dromaeo/cssquery-prototype.html) 06:04:24 INFO - PROCESS | 4191 | RSS: Main: 217612288 06:04:24 INFO - PROCESS | 4191 | 06:07:26 INFO - PROCESS | 4191 | Cycle 1(1): loaded http://localhost:46183/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46183/tests/dromaeo/cssquery-yui.html) 06:07:27 INFO - PROCESS | 4191 | RSS: Main: 227168256 06:07:27 INFO - PROCESS | 4191 | 06:10:29 INFO - PROCESS | 4191 | Cycle 1(1): loaded http://localhost:46183/tests/dromaeo/cssquery-yui.html (next: http://localhost:46183/tests/dromaeo/cssquery-dojo.html) 06:10:30 INFO - PROCESS | 4191 | RSS: Main: 268247040 06:10:30 INFO - PROCESS | 4191 | 06:10:30 INFO - PROCESS | 4191 | __start_tp_report 06:10:30 INFO - PROCESS | 4191 | _x_x_mozilla_page_load 06:10:30 INFO - PROCESS | 4191 | _x_x_mozilla_page_load_details 06:10:30 INFO - PROCESS | 4191 | |i|pagename|runs| 06:10:30 INFO - PROCESS | 4191 | |0;dojo.html;2569.319130430436;2647.602859571064;2665.4802313548867;2676.3978104926396;2696.5281075811736;4424.646028317735;4587;4595.356650068993;4602.838900638479;4621.884452888676;4601.585857272845;4603.723776573408;4605.125026245019;4618.838340658078;4625.421822272216;4130.215259100776;4211.978940105295;4265;4305.892352691192;4317.827286908519;4102.548719640837;4245.087306229176;4295.140971805636;4301.784910754465;4304.784760761965;4213.241616509027;4271.700980931336;4276.50820155683;4305.138972205571;4318.265894797892;4200.894977625553;4216.367544868263;4218.49378074633;4232.470941132358;4252.532221455637;4160.063985603245;4208.410822484854;4208.894777630553;4215.3887686285625;4251.532331443539;4520.367148599166;4557.065801510682;4558.407407037064;4571.817127314904;4592.74739889306;4967.751612419364;5004.149294619923;5005.824796132154;5009.148444764399;5015.39815222172;4790.353302304179;4903.926441103386;4986.925196122061;5010.048090862724;5028.522290382408;4557.339185818038;4571.131485017836;4576.885577860547;4598.0344127733215;4622.14490319292;5011.473795251519;5024.924626130611;5026.79892804291;5029.673071250357;5075.5178258065425;4742.407199100113;4802.927956080662;4812.25410061441;4881.536254055859;4897.069556784199;4912.852614421573;4915.311856340115;4929.704217746947;4930.580900623487;4975.800967961313;4853.757312134379;4862.07620552094;4864.270359446112;4879.438864530624;4910.042541704404;4666.463356714022;4781.880452988703;4832.661713680009;4871.8294859679745;4876.536729010738;4054.2296963576828;4063.349864021742;4063.4311196432523;4085.3667681509414;4099.487564054493;3549.3256281306467;3597.118705917067;3598.3163198992106;3617.077645200457;3633.255182687543;4195.098053918422;4218.114196018809;4252.829886804555;4282.76444795533;4295.742255464682;4873.658843880965;4883.926741098886;4892.412910450768;4901.950980490149;4948.777305021283;4122.2579935611875;4215.430916826189;4216.114615930689;4220.577942205816;4264.232438161161;4319.438472998553;4357.891052723644;4357.912841743211;4375.1031038637;4397.9560204398185;4623.953760462352;4642.466116396523;4643.883902902455;4669.509701481364;4687.835925742583;4751.7861696224445;4874.707517548958;4876.244182151772;4890.144224760724;4958.925616115689;4670.486246512949;4672.76636168197;4672.883177920579;4672.976635116803;4716.198246298069;4867.245576935581;4868;4870;4875.658703890694;4890.706557606555;4802.303665968485;4848.296996935495;4890.9021819562695;4905.77923993414;4970.055689418999;4786.664933454625;4795.95204047955;4799.784009719501;4816.590589799906;4838.225883858566;4783.928241076456;4786.114568804782;4790.089882922233;4790.712557246577;4837.395325584302;4554.7039442436135;4661.230896901973;4705.035467729039;4711.411073615798;4736.242201247784;4777;4783.497732738151;4804;4809.182438985311;4840.927386089141;4698.859034228979;4699.436067671902;4700.529947005409;4725.834595789131;4743.288506723881 06:10:30 INFO - PROCESS | 4191 | |1;ext.html;487.3372213789246;495.7446914838858;501.4484067525722;513.0073308148731;517.6583454919754;24885.75114248857;33362;33902.152446188855;33948.49077263843;33998.99999999997;35798.821005895;35934;36054.81972590133;36368;36484.63515364846;7562.886556701654;7740.690372385098;7746.186650401712;7748.845023099535;7753.340966017867;7351.117865856105;7931.762047138595;7932.405069619773;7933.920660793376;7934.801629959268;7893.605319733991;7981.6009199540085;7982.720604778834;7984;7989.760307190793;7331.193568707438;7334.266573342649;7336.376408005326;7346.155192152917;7946.801329966739;7697.846043079163;7802.921970780333;7804.804879877992;7813.218678132198;7816;35790.28419431623;36158.09604759876;36191.63808361936;36213;36286.63713362859;2889.1621429785337;2924.2981684395804;2951.7786166037417;2977.062225399014;3046.1470788179345;28163.85918070417;28205.85897070522;28300.15099547017;28517;28825.135245942656;3467.4105402081454;3505.1237190702323;3522.119470132467;3524.7708898921487;3597.9100522487147;161253.99999999884;161299.7090203686;161868;162267;162290;38117.618823811405;51776.48223517792;52043.47956520387;52048;52052.21921671178;36555.81722091426;36681.816590916875;36762.63237367592;36776.264474710355;36799.632003680155;10904.890951090387;11192.10463162945;11192.440377981231;11194.328340299608;11226.494807733672;8694.391392602583;8750.956245218733;8784;8787.604557794786;8791.912080879109;13085.149465284727;13147.211167329991;13503.932480337731;13511.797323040162;13630.591082267549;5265.605079619044;5329.866753331198;5367.3361258010145;5425.593080518976;5441.6190866639745;727.7853033355173;752.7139686918936;870.9433886797465;894.2890402130322;956.8566411238775;25574;26170.214893553224;26647.067352642563;26652.466950661266;26784.33039174036;706.5125063706026;866.921977022071;897.3404547657467;1011.9645812396531;1017.8625885505362;12312;12549.874501255053;12565.748685026248;12742.554010609769;12749.362531873368;262995;264935;266126;266419;266579;40516.39225411621;40615.39076913849;40823.59176408257;41819;42043.57956420397;1042.9791404171874;1101.801675698366;1104.9502772375263;1127.4081107418506;1296.3777386854174;23379.181728639414;23902.760972390053;24646;24679.87660061688;24709;33255.50116748299;33487.33025339528;33603.83198083994;33650.49524257089;33672.663273366954;150331;151047;151051;151400;315927;28626.713732863238;28842.134735957956;28860.567091493223;28879.7112028877;28918;33414;33579.49630755589;34407.31185376328;34528.82735586306;34578.48132277968;29169.270768230963;29203.707962920947;29624.555631665113;29644.25889352697;29834;29064;32099.35801284008;32346.676533234368;32351.676483234867;32407.675923240466;29691;29769.130013098158;38137;38616.42075368816;38795;32377.51433728543;33447;33553.96690496445;33587.49618755672;33782.324353512304;27481.45037099287;27645.447091057664;28019;28047.859760701067;28628.14115576536 06:10:30 INFO - PROCESS | 4191 | |2;jquery.html;335.92441700617366;337.30346833788224;339.3789365461206;339.61792982894247;342.8851334802842;14477.203753793538;15061.322240499176;15545.067295962235;15989.99999999997;16386.918065409685;14438.350274237659;14619.92690036551;14868.256587170652;15221;15329.923350383233;4809.7835597398025;4956.553910148086;4961.20620700688;4964.15609346412;4979.402471703401;4874.488178741234;4946.208606622941;4956.355673762406;4963.057019166365;4969.353983982077;4952.702837829742;4975.328330675348;4983.252512123192;4995.625328100407;5012.198048312271;4867.805287788484;4964.503549645025;4968.30443737877;4969.503049695038;5024.974875125601;4897.094037603019;4915;4916.852494425138;4941.629377796644;4957.256411538262;17463.912680436515;17523;19105.426837194907;19157.04214789255;19158.137883795123;1713.3660545598084;1800.7208882623083;1815.7821061472707;2094.49732064305;2164.7077644517944;8762.956185219096;9005.189532942066;9173.495457749821;12071.672116067226;12393.690157746038;1767.2312544043255;1782.857371410284;1787.115377887941;1793.7847458304957;1822.3712819077398;40415.595844041476;49400.50599493995;50045.499545004444;52573.211401829;56401.35986401327;8119.228673276029;9406.576704048197;9515.90484095164;9610.231181505464;9817.312788104764;10359.378437293786;10390.584376625002;10427.426491543038;10440.112590429746;12023;6002.519798416116;6045.425684559959;6065.150878876961;6166.660833654102;6185.195924529872;5662.734906037535;5688.857778555569;5745.8563535911935;5754.424557544296;5768.278965129359;3914.530256369254;3936.9015774605864;3997.7407116758127;4102.405151253111;4204.348326009474;1759.6128851652616;1773.6098058427126;1788.9552761181073;1790.8298711622374;1797.7752780902388;813.6460639621783;836.1262480707675;856.7943693513512;857.9442336248123;882.9072947340437;14875.851241487662;15426.46007389736;15573.065616063073;15738.449154279546;15955.521334359988;806.7216810200472;807.8182408958055;821.8561751693429;910.1171863292595;927.0729270729271;8799.164079412445;8918.509481978554;8971.416857904216;9006.234470070118;9075.230330085702;366033;377822;378707;385756.56973721297;393082;61217;61369.69315153396;63459.6827015862;63811;63866.68066659637;886.4016788667752;891.5364010714521;895.078069588312;898.2320116300469;903.4037535226719;13578.185308881499;13835.82395496394;13995.790063149265;14115.576532704035;14236.644083897985;24430.755692442846;24664.753352466247;24939.376515587257;28145.71854281431;29418.411631767674;36257.27485450329;37855.00934037945;41413;41634.1673166541;41735.37396939109;6917.204521479893;7034.47241456903;7043.97862309952;7178.820529486805;7193.928060719535;8129;10751.892481075402;11123.443827808738;11128.499217535069;11443.370614616277;7881.58131536329;9447.527623618655;9671.274654400808;10024.24818138628;10107.7473063174;9255.444673319622;9551.904480955101;9684.176844968257;9807.803843923224;9879.456629885426;9376.203022743142;9623.133917947418;9861.408315501092;9913.752156196153;10266.897331026594;7021.508494405342;7079.716811327489;7148.857022859618;7186.245444228281;7286.781396558112;7388.371988381048;9635.13283804461;9693.951530242304;9809.509524523603;10059.547320370455 06:10:30 INFO - PROCESS | 4191 | |3;mootools.html;1136.2273653915345;1361.2853252042678;1363.9590812275628;1498.887583431243;1754.2544418622083;6439.549231553793;7188.784336469901;7352.816179595499;7378.8893166602475;7380.2250763669845;7242.855142897139;7406.518576292538;7422.88865667014;7424.777256682295;7426.480146389755;1848.9167987440596;2181.0948456390656;2196.1544805249973;2226.0539270809923;2229.8216142708543;2217.81148602369;2229.3534874886263;2233.7542870284337;2234.765349638289;2236.027328112268;2135.0925856511;2192.725909261342;2199.087378737822;2203.0526873444414;2203.493196564791;2159.2334721173993;2168.8915554222303;2173.521825198454;2232.676261942009;2237.071615279673;2187.56248750249;2188.059134572133;2199.1093607089156;2200.1529411176653;2201.1085510368325;7591.582462964535;7667.731629392944;7676.193999630014;7677.500962437423;7682.116556596007;4474.306482495186;4584.679072464929;4587.7706114694465;4589.128065667513;4590.908181836345;2911.213972227487;2911.6651585067775;2954.8670309836107;2960.8371539565314;3047.634283885926;933.7945651956559;938.1884669760676;959.1990687775716;971.7424882406168;975.1954637424083;10555.261131720783;10567.207459440573;10582.365058096539;10584.206184536191;10601.628942987036;4201.117765269328;4365.738055716603;4387.736735795863;4447.710898791568;4452.666050046259;8878.511681857432;8909.821803564022;8919.910800892038;8928.866067009;8931.776705582412;3904.921901561953;4672.976635116803;4676.321933319718;4682.2508398656055;4683.531646835289;4018.136100738297;4105.261053010487;4118.155778065489;4139.503259608806;4140.047789008545;3547.9290414191573;3632.2917031179195;3657.7256705747177;3681.650243226889;3706.83319250629;1164.9690024328531;1174.5712814822527;1174.7180676637545;1179.6166245970094;1192.3263356203718;894.1996912763041;902.4810733827944;905.805251870851;911.6490151291667;1140.2759247877657;7174.426045916314;7197.100362454693;7206.315400036988;7232.421406287484;7239.058922340062;435.14711166114137;435.4970009638872;437.12792978009077;455.39432554702165;460.60618171463585;5063.3417655704525;5080.77136528857;5085.923711144335;5109.514596113363;5141.794328226829;9108.134727200906;9123.543822808833;9402.2948278878;9476.431414115175;9487.76280592977;9225.12361325673;9235.907640923639;9293.30300227472;9304.767380815398;9320.161185493202;6986.615736134561;7116.893246601305;7127.857442851114;7199.136103667489;7218.927810721825;6754.527183097136;6791.388775010273;6810.795676129724;6854.828629284308;6858.622775747382;7977.282044616012;8270.263244718435;8393.286570641563;8416.284615807725;8416.579171041545;8379.41344105931;8500;8637.179467950535;8654.22112009922;8663.696770612998;6518.107511484973;6589.374009469093;6671.33286671329;6679.465642748665;6685.465162787063;7187.712491500281;7195.46034047459;7220.566765994057;7239.963800180965;7244.601546914971;6308.779192728232;6398.680065996588;6458;6500.7399704013205;6611.636360000246;6443.67781610927;6453.838654033687;6525.477961762953;6543.5419520633095;6593.3736295051895;6873.518853680194;6908.2400935896;6911.274316196928;6945.895811562729;6955.721771129098;5944.4352786485215;6155.415235552616;6161.229846269216;6181.907271390843;6198.318184999556;6375.266844312778;6398.0083087121575;6429.7428102875365;6436.967815160894;6441.581297215666 06:10:30 INFO - PROCESS | 4191 | |4;prototype.html;304.7561950439648;305.660716604569;309.4445470380667;309.6856690459183;311.2297064764709;5186.792528298868;5277.050130976423;5334.359876814778;5353.491418315254;5390.460953904608;5224.92162617561;5225.059489291926;5253.080710875591;5276.630635855492;5278.524932756051;3892.766434013968;3975.7813320267373;4078.714489985695;4080.06158583526;4108.8356465741335;4072.796360181994;4103.261412945669;4106.7125301228925;4109.815058322382;4120.526139493952;4065.9390109148385;4069.674426045924;4071.7353372030725;4077.4903137107863;4078.877633670995;3845.365514690073;3938.6258305460933;4003.899902502432;4011.7162507997455;4016.518017837849;3489.45913383426;3498.247876706495;3500.0199944015717;3500.8949731508096;3501.2122272488486;5101.15830887903;5105.795768169306;5111.87220319495;5115.7442127893455;5116.386033675945;4632.953670463286;4635.374224479686;4636.072785442925;4636.698614590041;4640.373549570799;5575.553955683536;5578.135389014709;5578.916316255219;5583;5587.664740115565;3810.9618903810883;3811.27585758705;3811.885643430674;3813.180166264239;3813.370793819044;5615.46653067962;5871.647701137946;5873.882522349529;5876.9118463223085;5878.265216847852;3878.9612103879163;3905.023744063927;3907.765534067965;3908.6677632401565;3910.4720862683744;3961.643452089268;3962.484876965976;3963.781991990468;3963.960360396417;3965.8810235692977;4596.724196548218;4597.977010114995;4598.540145985375;4613.284940834176;4613.3771940787565;5574.526165275915;5577.8047768327915;5581.665100093926;5582.748776305076;5585.273914391184;1378.63466181462;1394.372532360442;1395.141987677571;1395.239594421043;1398.8391334996402;920.4615300049546;938.474454305591;954.8281309364243;961.1829944547219;963.0032915931977;4779.713217206979;4789.281607758794;4790;4814.085323788469;4846.273059041101;5687.800926967537;5695.743691533891;5712.285964254468;5769.163471296639;5771.163181338767;4818.518148185153;4820.566149046533;4834.129856625841;4835.734034628059;4847.418309802846;3058.250728571514;3065.6014718086954;3092.5515800208846;3095.4273459409633;3103.239706271933;5423.2136340230445;5429;5429;5431.158170483582;5439.292891924025;5733.397993210736;5876.118582212703;5887.911681324784;5890.646561206341;5890.764369425261;5390.703511306838;5397.433269506724;5410.1343784994215;5418.322709661293;5427.402985671573;5702.173184888085;5706.229658996149;5711.057675483498;5716.256886604715;5718.285214348207;5579.525740311957;5581.162825576033;5581.916271255853;5585.301837270341;5588.748506317307;5358.892822143457;5386.946130538801;5401.513863752281;5405.3513578369275;5407.513323800877;3785.09157802131;3859.498265225615;3886.6113388660906;3890.805459727059;3892.9026774329736;5550.58370622213;5658.236138121301;5688.203651488712;5688.77244910199;5695.829125126253;5407.188921661782;5467.58993075513;5522.144067669517;5581.023320918742;5611.270534830609;5563.248961390161;5563.944360556343;5573.665580065209;5605.439456054362;5606.607537472338;5467.480589344006;5475.342958844964;5477.75350109238;5480.780768769205;5489.64317319373;5620.213170156099;5632.211490391266;5643.097104463266;5646.407127251579;5647.632903861236;5337;5487.478689524489;5495.2856128703015;5497.8075767347955;5509.438111278275 06:10:30 INFO - PROCESS | 4191 | |5;yui.html;658.9703463344149;680.5542369747814;750.5534207146749;753.536575006371;765.720512013115;11718.472668729906;11904.107191960606;11905.940470297637;11916.463759130838;11921.344326062062;13130.474781008772;13392.330383480836;13398.129121607113;13416.865831341684;13438.99207559432;797.059469825607;815.0789607743242;815.9714409995652;816.2082779703678;816.9223923727236;625.8435391152212;790.8260182759784;802.8675268580677;812.7033632724073;815.2499700275731;848.893888263967;850.3154960256991;850.7235148576707;851.085083535199;851.2211326636151;838.2539539809513;844.025150950653;844.9746507604751;846.0693237438829;846.496334680867;479.45102857228625;611.9357467465941;619.4053708439903;620.764109638339;623.5915475363644;12200.755984880252;12211.206271592318;12226.938865305705;12280.324582147978;12283.57007504733;11288.322700637988;11363.488643011084;11482.311061336346;11771.470283837249;11935.283882966964;9551.474668893208;9607.663731769424;9695.321327507078;9703.07820757027;9802.5588848502;3153.668864769189;3171.7938334008445;3220.3237320162793;3247.691469310412;3293.275479394529;39791.60208397908;40166.59833401687;40795.184096318204;40801;40933.59066409327;9297.814043719087;9370.578323975438;9411;9578.329516933887;9674.371165874196;16109.27508262131;16114.274857631435;16134.112623805804;16228.594285142966;16231.51305460838;6246.906296405557;6261.5616906816995;6284.874302514016;6391.872162556816;6416.133821934072;3550.840212190458;3583.086312990171;3612.1692010837655;3653.9634603654154;3731.7574357666663;2667.3598336399514;2714.8914043438435;2715.592661100851;2715.7555819976296;2730.7678847297807;467.88770695032946;476.5044353872004;479.60911856837265;495.86611614863784;498.04624144762374;566.742132329789;599.7151353107239;616.7255571270741;620.4199073865859;628;7194.15119403137;7226.988221648973;7359.742409015766;7878.330341920886;7931.325837303893;604.9818505444844;607.0954278125649;618.6442795392667;620.7423919073624;626.1984659635674;3458.4639380896;3675.5956844747056;3696.445533170046;3758.2107757370713;3829.100161462054;47774;48749.26876096861;49009.509904901206;49326.50673493291;49328;41245.793771030956;42229;42541;45870.770646147226;45896.770516147204;41185;41999.370009449885;42051.36922946158;42260;43238.56761432345;8255.463394879314;8335;8390.496570205807;8445.268719912527;8558.657653693783;30151.547726783676;30302.84848575743;30512.542311864894;30694.618742157105;31228.219294517818;35358.646413535535;35381.169506438906;36248.637513624526;39310.80344598373;39311.803440982614;10696.465176741287;10801.891981080404;10939.124870010539;10961.232713710282;11112.833307500556;10696.358218506915;11069.446527673423;11240.494177761857;11245.918336778159;11487.310761354345;10471;10657.25399222047;10730.195235357223;11023.393713345842;11127.054200393057;10473.214508912015;10517.368957862553;10897.400642964712;10923.672289831318;11350.489227984595;10510.47447627631;10685.626003089854;10698.679039628823;10747.570097196338;11226.831597526207;8851.867221991804;8916.420432671855;9113.270938325051;9265.258779297505;9420.528973551158;9066.320025997944;9113.453192808453;9126.680566180152;9140.085991400807;9206.263498920205 06:10:30 INFO - PROCESS | 4191 | __end_tp_report 06:10:30 INFO - PROCESS | 4191 | __start_cc_report 06:10:30 INFO - PROCESS | 4191 | _x_x_mozilla_cycle_collect,918 06:10:30 INFO - PROCESS | 4191 | __end_cc_report 06:10:30 INFO - PROCESS | 4191 | __startTimestamp1457532630182__endTimestamp 06:10:30 INFO - PROCESS | 4191 | 06:10:30 INFO - PROCESS | 4191 | ------- Summary: start ------- 06:10:30 INFO - PROCESS | 4191 | Number of tests: 6 06:10:30 INFO - PROCESS | 4191 | 06:10:30 INFO - PROCESS | 4191 | [#0] dojo.html Cycles:165 Average:4537.76 Median:4670.49 stddev:468.85 (10.0%) stddev-sans-first:444.13 06:10:30 INFO - PROCESS | 4191 | Values: 2569.3 2647.6 2665.5 2676.4 2696.5 4424.6 4587.0 4595.4 4602.8 4621.9 4601.6 4603.7 4605.1 4618.8 4625.4 4130.2 4212.0 4265.0 4305.9 4317.8 4102.5 4245.1 4295.1 4301.8 4304.8 4213.2 4271.7 4276.5 4305.1 4318.3 4200.9 4216.4 4218.5 4232.5 4252.5 4160.1 4208.4 4208.9 4215.4 4251.5 4520.4 4557.1 4558.4 4571.8 4592.7 4967.8 5004.1 5005.8 5009.1 5015.4 4790.4 4903.9 4986.9 5010.0 5028.5 4557.3 4571.1 4576.9 4598.0 4622.1 5011.5 5024.9 5026.8 5029.7 5075.5 4742.4 4802.9 4812.3 4881.5 4897.1 4912.9 4915.3 4929.7 4930.6 4975.8 4853.8 4862.1 4864.3 4879.4 4910.0 4666.5 4781.9 4832.7 4871.8 4876.5 4054.2 4063.3 4063.4 4085.4 4099.5 3549.3 3597.1 3598.3 3617.1 3633.3 4195.1 4218.1 4252.8 4282.8 4295.7 4873.7 4883.9 4892.4 4902.0 4948.8 4122.3 4215.4 4216.1 4220.6 4264.2 4319.4 4357.9 4357.9 4375.1 4398.0 4624.0 4642.5 4643.9 4669.5 4687.8 4751.8 4874.7 4876.2 4890.1 4958.9 4670.5 4672.8 4672.9 4673.0 4716.2 4867.2 4868.0 4870.0 4875.7 4890.7 4802.3 4848.3 4890.9 4905.8 4970.1 4786.7 4796.0 4799.8 4816.6 4838.2 4783.9 4786.1 4790.1 4790.7 4837.4 4554.7 4661.2 4705.0 4711.4 4736.2 4777.0 4783.5 4804.0 4809.2 4840.9 4698.9 4699.4 4700.5 4725.8 4743.3 06:10:30 INFO - PROCESS | 4191 | 06:10:30 INFO - PROCESS | 4191 | [#1] ext.html Cycles:180 Average:35425.15 Median:33661.58 stddev:55404.68 (164.6%) stddev-sans-first:55498.00 06:10:30 INFO - PROCESS | 4191 | Values: 487.3 495.7 501.4 513.0 517.7 24885.8 33362.0 33902.2 33948.5 33999.0 35798.8 35934.0 36054.8 36368.0 36484.6 7562.9 7740.7 7746.2 7748.8 7753.3 7351.1 7931.8 7932.4 7933.9 7934.8 7893.6 7981.6 7982.7 7984.0 7989.8 7331.2 7334.3 7336.4 7346.2 7946.8 7697.8 7802.9 7804.8 7813.2 7816.0 35790.3 36158.1 36191.6 36213.0 36286.6 2889.2 2924.3 2951.8 2977.1 3046.1 28163.9 28205.9 28300.2 28517.0 28825.1 3467.4 3505.1 3522.1 3524.8 3597.9 161254.0 161299.7 161868.0 162267.0 162290.0 38117.6 51776.5 52043.5 52048.0 52052.2 36555.8 36681.8 36762.6 36776.3 36799.6 10904.9 11192.1 11192.4 11194.3 11226.5 8694.4 8751.0 8784.0 8787.6 8791.9 13085.1 13147.2 13503.9 13511.8 13630.6 5265.6 5329.9 5367.3 5425.6 5441.6 727.8 752.7 870.9 894.3 956.9 25574.0 26170.2 26647.1 26652.5 26784.3 706.5 866.9 897.3 1012.0 1017.9 12312.0 12549.9 12565.7 12742.6 12749.4 262995.0 264935.0 266126.0 266419.0 266579.0 40516.4 40615.4 40823.6 41819.0 42043.6 1043.0 1101.8 1105.0 1127.4 1296.4 23379.2 23902.8 24646.0 24679.9 24709.0 33255.5 33487.3 33603.8 33650.5 33672.7 150331.0 151047.0 151051.0 151400.0 315927.0 28626.7 28842.1 28860.6 28879.7 28918.0 33414.0 33579.5 34407.3 34528.8 34578.5 29169.3 29203.7 29624.6 29644.3 29834.0 29064.0 32099.4 32346.7 32351.7 32407.7 29691.0 29769.1 38137.0 38616.4 38795.0 32377.5 33447.0 33554.0 33587.5 33782.3 27481.5 27645.4 28019.0 28047.9 28628.1 06:10:30 INFO - PROCESS | 4191 | 06:10:30 INFO - PROCESS | 4191 | [#2] jquery.html Cycles:180 Average:21900.74 Median:4954.53 stddev:62218.32 (1255.8%) stddev-sans-first:62371.79 06:10:30 INFO - PROCESS | 4191 | Values: 335.9 337.3 339.4 339.6 342.9 14477.2 15061.3 15545.1 15990.0 16386.9 14438.4 14619.9 14868.3 15221.0 15329.9 4809.8 4956.6 4961.2 4964.2 4979.4 4874.5 4946.2 4956.4 4963.1 4969.4 4952.7 4975.3 4983.3 4995.6 5012.2 4867.8 4964.5 4968.3 4969.5 5025.0 4897.1 4915.0 4916.9 4941.6 4957.3 17463.9 17523.0 19105.4 19157.0 19158.1 1713.4 1800.7 1815.8 2094.5 2164.7 8763.0 9005.2 9173.5 12071.7 12393.7 1767.2 1782.9 1787.1 1793.8 1822.4 40415.6 49400.5 50045.5 52573.2 56401.4 8119.2 9406.6 9515.9 9610.2 9817.3 10359.4 10390.6 10427.4 10440.1 12023.0 6002.5 6045.4 6065.2 6166.7 6185.2 5662.7 5688.9 5745.9 5754.4 5768.3 3914.5 3936.9 3997.7 4102.4 4204.3 1759.6 1773.6 1789.0 1790.8 1797.8 813.6 836.1 856.8 857.9 882.9 14875.9 15426.5 15573.1 15738.4 15955.5 806.7 807.8 821.9 910.1 927.1 8799.2 8918.5 8971.4 9006.2 9075.2 366033.0 377822.0 378707.0 385756.6 393082.0 61217.0 61369.7 63459.7 63811.0 63866.7 886.4 891.5 895.1 898.2 903.4 13578.2 13835.8 13995.8 14115.6 14236.6 24430.8 24664.8 24939.4 28145.7 29418.4 36257.3 37855.0 41413.0 41634.2 41735.4 6917.2 7034.5 7044.0 7178.8 7193.9 8129.0 10751.9 11123.4 11128.5 11443.4 7881.6 9447.5 9671.3 10024.2 10107.7 9255.4 9551.9 9684.2 9807.8 9879.5 9376.2 9623.1 9861.4 9913.8 10266.9 7021.5 7079.7 7148.9 7186.2 7286.8 7388.4 9635.1 9694.0 9809.5 10059.5 06:10:30 INFO - PROCESS | 4191 | 06:10:30 INFO - PROCESS | 4191 | [#3] mootools.html Cycles:180 Average:5270.27 Median:6433.36 stddev:2805.83 (43.6%) stddev-sans-first:2796.50 06:10:30 INFO - PROCESS | 4191 | Values: 1136.2 1361.3 1364.0 1498.9 1754.3 6439.5 7188.8 7352.8 7378.9 7380.2 7242.9 7406.5 7422.9 7424.8 7426.5 1848.9 2181.1 2196.2 2226.1 2229.8 2217.8 2229.4 2233.8 2234.8 2236.0 2135.1 2192.7 2199.1 2203.1 2203.5 2159.2 2168.9 2173.5 2232.7 2237.1 2187.6 2188.1 2199.1 2200.2 2201.1 7591.6 7667.7 7676.2 7677.5 7682.1 4474.3 4584.7 4587.8 4589.1 4590.9 2911.2 2911.7 2954.9 2960.8 3047.6 933.8 938.2 959.2 971.7 975.2 10555.3 10567.2 10582.4 10584.2 10601.6 4201.1 4365.7 4387.7 4447.7 4452.7 8878.5 8909.8 8919.9 8928.9 8931.8 3904.9 4673.0 4676.3 4682.3 4683.5 4018.1 4105.3 4118.2 4139.5 4140.0 3547.9 3632.3 3657.7 3681.7 3706.8 1165.0 1174.6 1174.7 1179.6 1192.3 894.2 902.5 905.8 911.6 1140.3 7174.4 7197.1 7206.3 7232.4 7239.1 435.1 435.5 437.1 455.4 460.6 5063.3 5080.8 5085.9 5109.5 5141.8 9108.1 9123.5 9402.3 9476.4 9487.8 9225.1 9235.9 9293.3 9304.8 9320.2 6986.6 7116.9 7127.9 7199.1 7218.9 6754.5 6791.4 6810.8 6854.8 6858.6 7977.3 8270.3 8393.3 8416.3 8416.6 8379.4 8500.0 8637.2 8654.2 8663.7 6518.1 6589.4 6671.3 6679.5 6685.5 7187.7 7195.5 7220.6 7240.0 7244.6 6308.8 6398.7 6458.0 6500.7 6611.6 6443.7 6453.8 6525.5 6543.5 6593.4 6873.5 6908.2 6911.3 6945.9 6955.7 5944.4 6155.4 6161.2 6181.9 6198.3 6375.3 6398.0 6429.7 6437.0 6441.6 06:10:30 INFO - PROCESS | 4191 | 06:10:30 INFO - PROCESS | 4191 | [#4] prototype.html Cycles:180 Average:4580.90 Median:5277.79 stddev:1359.41 (25.8%) stddev-sans-first:1324.79 06:10:30 INFO - PROCESS | 4191 | Values: 304.8 305.7 309.4 309.7 311.2 5186.8 5277.1 5334.4 5353.5 5390.5 5224.9 5225.1 5253.1 5276.6 5278.5 3892.8 3975.8 4078.7 4080.1 4108.8 4072.8 4103.3 4106.7 4109.8 4120.5 4065.9 4069.7 4071.7 4077.5 4078.9 3845.4 3938.6 4003.9 4011.7 4016.5 3489.5 3498.2 3500.0 3500.9 3501.2 5101.2 5105.8 5111.9 5115.7 5116.4 4633.0 4635.4 4636.1 4636.7 4640.4 5575.6 5578.1 5578.9 5583.0 5587.7 3811.0 3811.3 3811.9 3813.2 3813.4 5615.5 5871.6 5873.9 5876.9 5878.3 3879.0 3905.0 3907.8 3908.7 3910.5 3961.6 3962.5 3963.8 3964.0 3965.9 4596.7 4598.0 4598.5 4613.3 4613.4 5574.5 5577.8 5581.7 5582.7 5585.3 1378.6 1394.4 1395.1 1395.2 1398.8 920.5 938.5 954.8 961.2 963.0 4779.7 4789.3 4790.0 4814.1 4846.3 5687.8 5695.7 5712.3 5769.2 5771.2 4818.5 4820.6 4834.1 4835.7 4847.4 3058.3 3065.6 3092.6 3095.4 3103.2 5423.2 5429.0 5429.0 5431.2 5439.3 5733.4 5876.1 5887.9 5890.6 5890.8 5390.7 5397.4 5410.1 5418.3 5427.4 5702.2 5706.2 5711.1 5716.3 5718.3 5579.5 5581.2 5581.9 5585.3 5588.7 5358.9 5386.9 5401.5 5405.4 5407.5 3785.1 3859.5 3886.6 3890.8 3892.9 5550.6 5658.2 5688.2 5688.8 5695.8 5407.2 5467.6 5522.1 5581.0 5611.3 5563.2 5563.9 5573.7 5605.4 5606.6 5467.5 5475.3 5477.8 5480.8 5489.6 5620.2 5632.2 5643.1 5646.4 5647.6 5337.0 5487.5 5495.3 5497.8 5509.4 06:10:30 INFO - PROCESS | 4191 | 06:10:30 INFO - PROCESS | 4191 | [#5] yui.html Cycles:180 Average:12265.18 Median:42400.50 stddev:13606.52 (32.1%) stddev-sans-first:13616.77 06:10:30 INFO - PROCESS | 4191 | Values: 659.0 680.6 750.6 753.5 765.7 11718.5 11904.1 11905.9 11916.5 11921.3 13130.5 13392.3 13398.1 13416.9 13439.0 797.1 815.1 816.0 816.2 816.9 625.8 790.8 802.9 812.7 815.2 848.9 850.3 850.7 851.1 851.2 838.3 844.0 845.0 846.1 846.5 479.5 611.9 619.4 620.8 623.6 12200.8 12211.2 12226.9 12280.3 12283.6 11288.3 11363.5 11482.3 11771.5 11935.3 9551.5 9607.7 9695.3 9703.1 9802.6 3153.7 3171.8 3220.3 3247.7 3293.3 39791.6 40166.6 40795.2 40801.0 40933.6 9297.8 9370.6 9411.0 9578.3 9674.4 16109.3 16114.3 16134.1 16228.6 16231.5 6246.9 6261.6 6284.9 6391.9 6416.1 3550.8 3583.1 3612.2 3654.0 3731.8 2667.4 2714.9 2715.6 2715.8 2730.8 467.9 476.5 479.6 495.9 498.0 566.7 599.7 616.7 620.4 628.0 7194.2 7227.0 7359.7 7878.3 7931.3 605.0 607.1 618.6 620.7 626.2 3458.5 3675.6 3696.4 3758.2 3829.1 47774.0 48749.3 49009.5 49326.5 49328.0 41245.8 42229.0 42541.0 45870.8 45896.8 41185.0 41999.4 42051.4 42260.0 43238.6 8255.5 8335.0 8390.5 8445.3 8558.7 30151.5 30302.8 30512.5 30694.6 31228.2 35358.6 35381.2 36248.6 39310.8 39311.8 10696.5 10801.9 10939.1 10961.2 11112.8 10696.4 11069.4 11240.5 11245.9 11487.3 10471.0 10657.3 10730.2 11023.4 11127.1 10473.2 10517.4 10897.4 10923.7 11350.5 10510.5 10685.6 10698.7 10747.6 11226.8 8851.9 8916.4 9113.3 9265.3 9420.5 9066.3 9113.5 9126.7 9140.1 9206.3 06:10:30 INFO - PROCESS | 4191 | -------- Summary: end -------- 06:10:30 INFO - PROCESS | 4191 | 06:10:30 INFO - TEST-INFO | 4191: exit 0 06:10:30 INFO - TEST-OK | dromaeo_css | took 1116514ms 06:10:30 INFO - TEST-START | kraken 06:10:30 INFO - operating with platform_type : linux_ 06:10:30 INFO - Initialising browser for kraken test... 06:10:30 INFO - TEST-INFO | started process 4365 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOb10hK/profile http://localhost:46183/getInfo.html) 06:10:35 INFO - PROCESS | 4365 | __metrics Screen width/height:1600/1200 06:10:35 INFO - PROCESS | 4365 | colorDepth:24 06:10:35 INFO - PROCESS | 4365 | Browser inner width/height: 1024/697 06:10:35 INFO - PROCESS | 4365 | __metrics 06:10:36 ERROR - PROCESS | 4365 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:10:36 INFO - PROCESS | 4365 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 06:10:37 INFO - TEST-INFO | 4365: exit 0 06:10:37 INFO - Browser initialized. 06:10:37 INFO - Running cycle 1/1 for kraken test... 06:10:37 INFO - TEST-INFO | started process 4448 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOb10hK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:10:49 INFO - PROCESS | 4448 | RSS: Main: 154501120 06:10:49 INFO - PROCESS | 4448 | 06:10:51 INFO - PROCESS | 4448 | Cycle 1(1): loaded http://localhost:46183/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46183/tests/kraken/driver.html?testName=audio-beat-detection) 06:10:52 INFO - PROCESS | 4448 | RSS: Main: 193851392 06:10:52 INFO - PROCESS | 4448 | 06:10:55 INFO - PROCESS | 4448 | Cycle 1(1): loaded http://localhost:46183/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46183/tests/kraken/driver.html?testName=audio-dft) 06:10:55 INFO - PROCESS | 4448 | RSS: Main: 184205312 06:10:55 INFO - PROCESS | 4448 | 06:10:58 INFO - PROCESS | 4448 | Cycle 1(1): loaded http://localhost:46183/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46183/tests/kraken/driver.html?testName=audio-fft) 06:10:59 INFO - PROCESS | 4448 | RSS: Main: 171266048 06:10:59 INFO - PROCESS | 4448 | 06:11:01 INFO - PROCESS | 4448 | Cycle 1(1): loaded http://localhost:46183/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46183/tests/kraken/driver.html?testName=audio-oscillator) 06:11:01 INFO - PROCESS | 4448 | RSS: Main: 172449792 06:11:01 INFO - PROCESS | 4448 | 06:11:04 INFO - PROCESS | 4448 | Cycle 1(1): loaded http://localhost:46183/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46183/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:11:04 INFO - PROCESS | 4448 | RSS: Main: 173555712 06:11:04 INFO - PROCESS | 4448 | 06:11:07 INFO - PROCESS | 4448 | Cycle 1(1): loaded http://localhost:46183/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46183/tests/kraken/driver.html?testName=imaging-darkroom) 06:11:08 INFO - PROCESS | 4448 | RSS: Main: 174022656 06:11:08 INFO - PROCESS | 4448 | 06:11:12 INFO - PROCESS | 4448 | Cycle 1(1): loaded http://localhost:46183/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46183/tests/kraken/driver.html?testName=imaging-desaturate) 06:11:12 INFO - PROCESS | 4448 | RSS: Main: 172163072 06:11:12 INFO - PROCESS | 4448 | 06:11:15 INFO - PROCESS | 4448 | Cycle 1(1): loaded http://localhost:46183/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46183/tests/kraken/driver.html?testName=json-parse-financial) 06:11:16 INFO - PROCESS | 4448 | RSS: Main: 174563328 06:11:16 INFO - PROCESS | 4448 | 06:11:17 INFO - PROCESS | 4448 | Cycle 1(1): loaded http://localhost:46183/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46183/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:11:18 INFO - PROCESS | 4448 | RSS: Main: 186933248 06:11:18 INFO - PROCESS | 4448 | 06:11:20 INFO - PROCESS | 4448 | Cycle 1(1): loaded http://localhost:46183/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46183/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:11:21 INFO - PROCESS | 4448 | RSS: Main: 183889920 06:11:21 INFO - PROCESS | 4448 | 06:11:23 INFO - PROCESS | 4448 | Cycle 1(1): loaded http://localhost:46183/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46183/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:11:23 INFO - PROCESS | 4448 | RSS: Main: 194367488 06:11:23 INFO - PROCESS | 4448 | 06:11:26 INFO - PROCESS | 4448 | Cycle 1(1): loaded http://localhost:46183/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46183/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:11:26 INFO - PROCESS | 4448 | RSS: Main: 196976640 06:11:26 INFO - PROCESS | 4448 | 06:11:29 INFO - PROCESS | 4448 | Cycle 1(1): loaded http://localhost:46183/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46183/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:11:30 INFO - PROCESS | 4448 | RSS: Main: 198000640 06:11:30 INFO - PROCESS | 4448 | 06:11:31 INFO - PROCESS | 4448 | Cycle 1(1): loaded http://localhost:46183/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46183/tests/kraken/driver.html?testName=ai-astar) 06:11:32 INFO - PROCESS | 4448 | RSS: Main: 257175552 06:11:32 INFO - PROCESS | 4448 | 06:11:32 INFO - PROCESS | 4448 | __start_tp_report 06:11:32 INFO - PROCESS | 4448 | _x_x_mozilla_page_load 06:11:32 INFO - PROCESS | 4448 | _x_x_mozilla_page_load_details 06:11:32 INFO - PROCESS | 4448 | |i|pagename|runs| 06:11:32 INFO - PROCESS | 4448 | |0;ai-astar;110;113;107;112;113;112;101;111;112;113 06:11:32 INFO - PROCESS | 4448 | |1;audio-beat-detection;159;132;154;180;134;166;155;150;177;130 06:11:32 INFO - PROCESS | 4448 | |2;audio-dft;162;162;163;161;162;160;164;164;162;162 06:11:32 INFO - PROCESS | 4448 | |3;audio-fft;75;78;112;107;74;74;74;116;94;76 06:11:32 INFO - PROCESS | 4448 | |4;audio-oscillator;96;95;137;94;96;96;145;94;95;129 06:11:32 INFO - PROCESS | 4448 | |5;imaging-gaussian-blur;117;117;116;117;117;117;118;116;117;117 06:11:32 INFO - PROCESS | 4448 | |6;imaging-darkroom;147;147;146;147;146;145;146;147;146;146 06:11:32 INFO - PROCESS | 4448 | |7;imaging-desaturate;95;96;95;95;95;96;97;95;95;96 06:11:32 INFO - PROCESS | 4448 | |8;json-parse-financial;69;69;68;68;68;69;70;77;66;66 06:11:32 INFO - PROCESS | 4448 | |9;json-stringify-tinderbox;70;71;70;70;70;71;70;71;70;71 06:11:32 INFO - PROCESS | 4448 | |10;stanford-crypto-aes;81;83;84;83;85;82;87;82;83;84 06:11:32 INFO - PROCESS | 4448 | |11;stanford-crypto-ccm;129;123;128;118;120;120;124;122;118;129 06:11:32 INFO - PROCESS | 4448 | |12;stanford-crypto-pbkdf2;165;148;152;146;152;142;145;146;145;150 06:11:32 INFO - PROCESS | 4448 | |13;stanford-crypto-sha256-iterative;70;72;73;72;71;71;70;71;70;70 06:11:32 INFO - PROCESS | 4448 | __end_tp_report 06:11:32 INFO - PROCESS | 4448 | __start_cc_report 06:11:32 INFO - PROCESS | 4448 | _x_x_mozilla_cycle_collect,1147 06:11:32 INFO - PROCESS | 4448 | __end_cc_report 06:11:32 INFO - PROCESS | 4448 | __startTimestamp1457532692176__endTimestamp 06:11:32 INFO - PROCESS | 4448 | 06:11:32 INFO - PROCESS | 4448 | ------- Summary: start ------- 06:11:32 INFO - PROCESS | 4448 | Number of tests: 14 06:11:32 INFO - PROCESS | 4448 | 06:11:32 INFO - PROCESS | 4448 | [#0] ai-astar Cycles:10 Average:110.40 Median:112.00 stddev:3.78 (3.4%) stddev-sans-first:4.00 06:11:32 INFO - PROCESS | 4448 | Values: 110.0 113.0 107.0 112.0 113.0 112.0 101.0 111.0 112.0 113.0 06:11:32 INFO - PROCESS | 4448 | 06:11:32 INFO - PROCESS | 4448 | [#1] audio-beat-detection Cycles:10 Average:153.70 Median:157.00 stddev:17.80 (11.3%) stddev-sans-first:18.77 06:11:32 INFO - PROCESS | 4448 | Values: 159.0 132.0 154.0 180.0 134.0 166.0 155.0 150.0 177.0 130.0 06:11:32 INFO - PROCESS | 4448 | 06:11:32 INFO - PROCESS | 4448 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:1.23 (0.8%) stddev-sans-first:1.30 06:11:32 INFO - PROCESS | 4448 | Values: 162.0 162.0 163.0 161.0 162.0 160.0 164.0 164.0 162.0 162.0 06:11:32 INFO - PROCESS | 4448 | 06:11:32 INFO - PROCESS | 4448 | [#3] audio-fft Cycles:10 Average:88.00 Median:74.50 stddev:17.51 (23.5%) stddev-sans-first:17.92 06:11:32 INFO - PROCESS | 4448 | Values: 75.0 78.0 112.0 107.0 74.0 74.0 74.0 116.0 94.0 76.0 06:11:32 INFO - PROCESS | 4448 | 06:11:32 INFO - PROCESS | 4448 | [#4] audio-oscillator Cycles:10 Average:107.70 Median:95.00 stddev:20.58 (21.7%) stddev-sans-first:21.39 06:11:32 INFO - PROCESS | 4448 | Values: 96.0 95.0 137.0 94.0 96.0 96.0 145.0 94.0 95.0 129.0 06:11:32 INFO - PROCESS | 4448 | 06:11:32 INFO - PROCESS | 4448 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 06:11:32 INFO - PROCESS | 4448 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 118.0 116.0 117.0 117.0 06:11:32 INFO - PROCESS | 4448 | 06:11:32 INFO - PROCESS | 4448 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.50 stddev:0.67 (0.5%) stddev-sans-first:0.67 06:11:32 INFO - PROCESS | 4448 | Values: 147.0 147.0 146.0 147.0 146.0 145.0 146.0 147.0 146.0 146.0 06:11:32 INFO - PROCESS | 4448 | 06:11:32 INFO - PROCESS | 4448 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 06:11:32 INFO - PROCESS | 4448 | Values: 95.0 96.0 95.0 95.0 95.0 96.0 97.0 95.0 95.0 96.0 06:11:32 INFO - PROCESS | 4448 | 06:11:32 INFO - PROCESS | 4448 | [#8] json-parse-financial Cycles:10 Average:69.00 Median:69.00 stddev:3.09 (4.5%) stddev-sans-first:3.28 06:11:32 INFO - PROCESS | 4448 | Values: 69.0 69.0 68.0 68.0 68.0 69.0 70.0 77.0 66.0 66.0 06:11:32 INFO - PROCESS | 4448 | 06:11:32 INFO - PROCESS | 4448 | [#9] json-stringify-tinderbox Cycles:10 Average:70.40 Median:70.50 stddev:0.52 (0.7%) stddev-sans-first:0.53 06:11:32 INFO - PROCESS | 4448 | Values: 70.0 71.0 70.0 70.0 70.0 71.0 70.0 71.0 70.0 71.0 06:11:32 INFO - PROCESS | 4448 | 06:11:32 INFO - PROCESS | 4448 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:83.50 stddev:1.71 (2.1%) stddev-sans-first:1.58 06:11:32 INFO - PROCESS | 4448 | Values: 81.0 83.0 84.0 83.0 85.0 82.0 87.0 82.0 83.0 84.0 06:11:32 INFO - PROCESS | 4448 | 06:11:32 INFO - PROCESS | 4448 | [#11] stanford-crypto-ccm Cycles:10 Average:123.10 Median:123.50 stddev:4.31 (3.5%) stddev-sans-first:4.00 06:11:32 INFO - PROCESS | 4448 | Values: 129.0 123.0 128.0 118.0 120.0 120.0 124.0 122.0 118.0 129.0 06:11:32 INFO - PROCESS | 4448 | 06:11:32 INFO - PROCESS | 4448 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.10 Median:149.00 stddev:6.45 (4.3%) stddev-sans-first:3.43 06:11:32 INFO - PROCESS | 4448 | Values: 165.0 148.0 152.0 146.0 152.0 142.0 145.0 146.0 145.0 150.0 06:11:32 INFO - PROCESS | 4448 | 06:11:32 INFO - PROCESS | 4448 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.00 Median:71.00 stddev:1.05 (1.5%) stddev-sans-first:1.05 06:11:32 INFO - PROCESS | 4448 | Values: 70.0 72.0 73.0 72.0 71.0 71.0 70.0 71.0 70.0 70.0 06:11:32 INFO - PROCESS | 4448 | -------- Summary: end -------- 06:11:32 INFO - PROCESS | 4448 | 06:11:33 INFO - TEST-INFO | 4448: exit 0 06:11:33 INFO - TEST-OK | kraken | took 62290ms 06:11:33 INFO - SUITE-END | took 1178s 06:11:33 INFO - Completed test suite (00:19:38) 06:11:33 INFO - javascript benchmark 06:11:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2569.319130430436, 2647.602859571064, 2665.4802313548867, 2676.3978104926396, 2696.5281075811736, 4424.646028317735, 4587.0, 4595.356650068993, 4602.838900638479, 4621.884452888676, 4601.585857272845, 4603.723776573408, 4605.125026245019, 4618.838340658078, 4625.421822272216, 4130.215259100776, 4211.978940105295, 4265.0, 4305.892352691192, 4317.827286908519, 4102.548719640837, 4245.087306229176, 4295.140971805636, 4301.784910754465, 4304.784760761965, 4213.241616509027, 4271.700980931336, 4276.50820155683, 4305.138972205571, 4318.265894797892, 4200.894977625553, 4216.367544868263, 4218.49378074633, 4232.470941132358, 4252.532221455637, 4160.063985603245, 4208.410822484854, 4208.894777630553, 4215.3887686285625, 4251.532331443539, 4520.367148599166, 4557.065801510682, 4558.407407037064, 4571.817127314904, 4592.74739889306, 4967.751612419364, 5004.149294619923, 5005.824796132154, 5009.148444764399, 5015.39815222172, 4790.353302304179, 4903.926441103386, 4986.925196122061, 5010.048090862724, 5028.522290382408, 4557.339185818038, 4571.131485017836, 4576.885577860547, 4598.0344127733215, 4622.14490319292, 5011.473795251519, 5024.924626130611, 5026.79892804291, 5029.673071250357, 5075.5178258065425, 4742.407199100113, 4802.927956080662, 4812.25410061441, 4881.536254055859, 4897.069556784199, 4912.852614421573, 4915.311856340115, 4929.704217746947, 4930.580900623487, 4975.800967961313, 4853.757312134379, 4862.07620552094, 4864.270359446112, 4879.438864530624, 4910.042541704404, 4666.463356714022, 4781.880452988703, 4832.661713680009, 4871.8294859679745, 4876.536729010738, 4054.2296963576828, 4063.349864021742, 4063.4311196432523, 4085.3667681509414, 4099.487564054493, 3549.3256281306467, 3597.118705917067, 3598.3163198992106, 3617.077645200457, 3633.255182687543, 4195.098053918422, 4218.114196018809, 4252.829886804555, 4282.76444795533, 4295.742255464682, 4873.658843880965, 4883.926741098886, 4892.412910450768, 4901.950980490149, 4948.777305021283, 4122.2579935611875, 4215.430916826189, 4216.114615930689, 4220.577942205816, 4264.232438161161, 4319.438472998553, 4357.891052723644, 4357.912841743211, 4375.1031038637, 4397.9560204398185, 4623.953760462352, 4642.466116396523, 4643.883902902455, 4669.509701481364, 4687.835925742583, 4751.7861696224445, 4874.707517548958, 4876.244182151772, 4890.144224760724, 4958.925616115689, 4670.486246512949, 4672.76636168197, 4672.883177920579, 4672.976635116803, 4716.198246298069, 4867.245576935581, 4868.0, 4870.0, 4875.658703890694, 4890.706557606555, 4802.303665968485, 4848.296996935495, 4890.9021819562695, 4905.77923993414, 4970.055689418999, 4786.664933454625, 4795.95204047955, 4799.784009719501, 4816.590589799906, 4838.225883858566, 4783.928241076456, 4786.114568804782, 4790.089882922233, 4790.712557246577, 4837.395325584302, 4554.7039442436135, 4661.230896901973, 4705.035467729039, 4711.411073615798, 4736.242201247784, 4777.0, 4783.497732738151, 4804.0, 4809.182438985311, 4840.927386089141, 4698.859034228979, 4699.436067671902, 4700.529947005409, 4725.834595789131, 4743.288506723881], "unit": "score", "name": "dojo.html", "value": 4508.8129375588815}, {"lowerIsBetter": false, "replicates": [487.3372213789246, 495.7446914838858, 501.4484067525722, 513.0073308148731, 517.6583454919754, 24885.75114248857, 33362.0, 33902.152446188855, 33948.49077263843, 33998.99999999997, 35798.821005895, 35934.0, 36054.81972590133, 36368.0, 36484.63515364846, 7562.886556701654, 7740.690372385098, 7746.186650401712, 7748.845023099535, 7753.340966017867, 7351.117865856105, 7931.762047138595, 7932.405069619773, 7933.920660793376, 7934.801629959268, 7893.605319733991, 7981.6009199540085, 7982.720604778834, 7984.0, 7989.760307190793, 7331.193568707438, 7334.266573342649, 7336.376408005326, 7346.155192152917, 7946.801329966739, 7697.846043079163, 7802.921970780333, 7804.804879877992, 7813.218678132198, 7816.0, 35790.28419431623, 36158.09604759876, 36191.63808361936, 36213.0, 36286.63713362859, 2889.1621429785337, 2924.2981684395804, 2951.7786166037417, 2977.062225399014, 3046.1470788179345, 28163.85918070417, 28205.85897070522, 28300.15099547017, 28517.0, 28825.135245942656, 3467.4105402081454, 3505.1237190702323, 3522.119470132467, 3524.7708898921487, 3597.9100522487147, 161253.99999999884, 161299.7090203686, 161868.0, 162267.0, 162290.0, 38117.618823811405, 51776.48223517792, 52043.47956520387, 52048.0, 52052.21921671178, 36555.81722091426, 36681.816590916875, 36762.63237367592, 36776.264474710355, 36799.632003680155, 10904.890951090387, 11192.10463162945, 11192.440377981231, 11194.328340299608, 11226.494807733672, 8694.391392602583, 8750.956245218733, 8784.0, 8787.604557794786, 8791.912080879109, 13085.149465284727, 13147.211167329991, 13503.932480337731, 13511.797323040162, 13630.591082267549, 5265.605079619044, 5329.866753331198, 5367.3361258010145, 5425.593080518976, 5441.6190866639745, 727.7853033355173, 752.7139686918936, 870.9433886797465, 894.2890402130322, 956.8566411238775, 25574.0, 26170.214893553224, 26647.067352642563, 26652.466950661266, 26784.33039174036, 706.5125063706026, 866.921977022071, 897.3404547657467, 1011.9645812396531, 1017.8625885505362, 12312.0, 12549.874501255053, 12565.748685026248, 12742.554010609769, 12749.362531873368, 262995.0, 264935.0, 266126.0, 266419.0, 266579.0, 40516.39225411621, 40615.39076913849, 40823.59176408257, 41819.0, 42043.57956420397, 1042.9791404171874, 1101.801675698366, 1104.9502772375263, 1127.4081107418506, 1296.3777386854174, 23379.181728639414, 23902.760972390053, 24646.0, 24679.87660061688, 24709.0, 33255.50116748299, 33487.33025339528, 33603.83198083994, 33650.49524257089, 33672.663273366954, 150331.0, 151047.0, 151051.0, 151400.0, 315927.0, 28626.713732863238, 28842.134735957956, 28860.567091493223, 28879.7112028877, 28918.0, 33414.0, 33579.49630755589, 34407.31185376328, 34528.82735586306, 34578.48132277968, 29169.270768230963, 29203.707962920947, 29624.555631665113, 29644.25889352697, 29834.0, 29064.0, 32099.35801284008, 32346.676533234368, 32351.676483234867, 32407.675923240466, 29691.0, 29769.130013098158, 38137.0, 38616.42075368816, 38795.0, 32377.51433728543, 33447.0, 33553.96690496445, 33587.49618755672, 33782.324353512304, 27481.45037099287, 27645.447091057664, 28019.0, 28047.859760701067, 28628.14115576536], "unit": "score", "name": "ext.html", "value": 15347.816943500104}, {"lowerIsBetter": false, "replicates": [335.92441700617366, 337.30346833788224, 339.3789365461206, 339.61792982894247, 342.8851334802842, 14477.203753793538, 15061.322240499176, 15545.067295962235, 15989.99999999997, 16386.918065409685, 14438.350274237659, 14619.92690036551, 14868.256587170652, 15221.0, 15329.923350383233, 4809.7835597398025, 4956.553910148086, 4961.20620700688, 4964.15609346412, 4979.402471703401, 4874.488178741234, 4946.208606622941, 4956.355673762406, 4963.057019166365, 4969.353983982077, 4952.702837829742, 4975.328330675348, 4983.252512123192, 4995.625328100407, 5012.198048312271, 4867.805287788484, 4964.503549645025, 4968.30443737877, 4969.503049695038, 5024.974875125601, 4897.094037603019, 4915.0, 4916.852494425138, 4941.629377796644, 4957.256411538262, 17463.912680436515, 17523.0, 19105.426837194907, 19157.04214789255, 19158.137883795123, 1713.3660545598084, 1800.7208882623083, 1815.7821061472707, 2094.49732064305, 2164.7077644517944, 8762.956185219096, 9005.189532942066, 9173.495457749821, 12071.672116067226, 12393.690157746038, 1767.2312544043255, 1782.857371410284, 1787.115377887941, 1793.7847458304957, 1822.3712819077398, 40415.595844041476, 49400.50599493995, 50045.499545004444, 52573.211401829, 56401.35986401327, 8119.228673276029, 9406.576704048197, 9515.90484095164, 9610.231181505464, 9817.312788104764, 10359.378437293786, 10390.584376625002, 10427.426491543038, 10440.112590429746, 12023.0, 6002.519798416116, 6045.425684559959, 6065.150878876961, 6166.660833654102, 6185.195924529872, 5662.734906037535, 5688.857778555569, 5745.8563535911935, 5754.424557544296, 5768.278965129359, 3914.530256369254, 3936.9015774605864, 3997.7407116758127, 4102.405151253111, 4204.348326009474, 1759.6128851652616, 1773.6098058427126, 1788.9552761181073, 1790.8298711622374, 1797.7752780902388, 813.6460639621783, 836.1262480707675, 856.7943693513512, 857.9442336248123, 882.9072947340437, 14875.851241487662, 15426.46007389736, 15573.065616063073, 15738.449154279546, 15955.521334359988, 806.7216810200472, 807.8182408958055, 821.8561751693429, 910.1171863292595, 927.0729270729271, 8799.164079412445, 8918.509481978554, 8971.416857904216, 9006.234470070118, 9075.230330085702, 366033.0, 377822.0, 378707.0, 385756.56973721297, 393082.0, 61217.0, 61369.69315153396, 63459.6827015862, 63811.0, 63866.68066659637, 886.4016788667752, 891.5364010714521, 895.078069588312, 898.2320116300469, 903.4037535226719, 13578.185308881499, 13835.82395496394, 13995.790063149265, 14115.576532704035, 14236.644083897985, 24430.755692442846, 24664.753352466247, 24939.376515587257, 28145.71854281431, 29418.411631767674, 36257.27485450329, 37855.00934037945, 41413.0, 41634.1673166541, 41735.37396939109, 6917.204521479893, 7034.47241456903, 7043.97862309952, 7178.820529486805, 7193.928060719535, 8129.0, 10751.892481075402, 11123.443827808738, 11128.499217535069, 11443.370614616277, 7881.58131536329, 9447.527623618655, 9671.274654400808, 10024.24818138628, 10107.7473063174, 9255.444673319622, 9551.904480955101, 9684.176844968257, 9807.803843923224, 9879.456629885426, 9376.203022743142, 9623.133917947418, 9861.408315501092, 9913.752156196153, 10266.897331026594, 7021.508494405342, 7079.716811327489, 7148.857022859618, 7186.245444228281, 7286.781396558112, 7388.371988381048, 9635.13283804461, 9693.951530242304, 9809.509524523603, 10059.547320370455], "unit": "score", "name": "jquery.html", "value": 7460.785430215809}, {"lowerIsBetter": false, "replicates": [1136.2273653915345, 1361.2853252042678, 1363.9590812275628, 1498.887583431243, 1754.2544418622083, 6439.549231553793, 7188.784336469901, 7352.816179595499, 7378.8893166602475, 7380.2250763669845, 7242.855142897139, 7406.518576292538, 7422.88865667014, 7424.777256682295, 7426.480146389755, 1848.9167987440596, 2181.0948456390656, 2196.1544805249973, 2226.0539270809923, 2229.8216142708543, 2217.81148602369, 2229.3534874886263, 2233.7542870284337, 2234.765349638289, 2236.027328112268, 2135.0925856511, 2192.725909261342, 2199.087378737822, 2203.0526873444414, 2203.493196564791, 2159.2334721173993, 2168.8915554222303, 2173.521825198454, 2232.676261942009, 2237.071615279673, 2187.56248750249, 2188.059134572133, 2199.1093607089156, 2200.1529411176653, 2201.1085510368325, 7591.582462964535, 7667.731629392944, 7676.193999630014, 7677.500962437423, 7682.116556596007, 4474.306482495186, 4584.679072464929, 4587.7706114694465, 4589.128065667513, 4590.908181836345, 2911.213972227487, 2911.6651585067775, 2954.8670309836107, 2960.8371539565314, 3047.634283885926, 933.7945651956559, 938.1884669760676, 959.1990687775716, 971.7424882406168, 975.1954637424083, 10555.261131720783, 10567.207459440573, 10582.365058096539, 10584.206184536191, 10601.628942987036, 4201.117765269328, 4365.738055716603, 4387.736735795863, 4447.710898791568, 4452.666050046259, 8878.511681857432, 8909.821803564022, 8919.910800892038, 8928.866067009, 8931.776705582412, 3904.921901561953, 4672.976635116803, 4676.321933319718, 4682.2508398656055, 4683.531646835289, 4018.136100738297, 4105.261053010487, 4118.155778065489, 4139.503259608806, 4140.047789008545, 3547.9290414191573, 3632.2917031179195, 3657.7256705747177, 3681.650243226889, 3706.83319250629, 1164.9690024328531, 1174.5712814822527, 1174.7180676637545, 1179.6166245970094, 1192.3263356203718, 894.1996912763041, 902.4810733827944, 905.805251870851, 911.6490151291667, 1140.2759247877657, 7174.426045916314, 7197.100362454693, 7206.315400036988, 7232.421406287484, 7239.058922340062, 435.14711166114137, 435.4970009638872, 437.12792978009077, 455.39432554702165, 460.60618171463585, 5063.3417655704525, 5080.77136528857, 5085.923711144335, 5109.514596113363, 5141.794328226829, 9108.134727200906, 9123.543822808833, 9402.2948278878, 9476.431414115175, 9487.76280592977, 9225.12361325673, 9235.907640923639, 9293.30300227472, 9304.767380815398, 9320.161185493202, 6986.615736134561, 7116.893246601305, 7127.857442851114, 7199.136103667489, 7218.927810721825, 6754.527183097136, 6791.388775010273, 6810.795676129724, 6854.828629284308, 6858.622775747382, 7977.282044616012, 8270.263244718435, 8393.286570641563, 8416.284615807725, 8416.579171041545, 8379.41344105931, 8500.0, 8637.179467950535, 8654.22112009922, 8663.696770612998, 6518.107511484973, 6589.374009469093, 6671.33286671329, 6679.465642748665, 6685.465162787063, 7187.712491500281, 7195.46034047459, 7220.566765994057, 7239.963800180965, 7244.601546914971, 6308.779192728232, 6398.680065996588, 6458.0, 6500.7399704013205, 6611.636360000246, 6443.67781610927, 6453.838654033687, 6525.477961762953, 6543.5419520633095, 6593.3736295051895, 6873.518853680194, 6908.2400935896, 6911.274316196928, 6945.895811562729, 6955.721771129098, 5944.4352786485215, 6155.415235552616, 6161.229846269216, 6181.907271390843, 6198.318184999556, 6375.266844312778, 6398.0083087121575, 6429.7428102875365, 6436.967815160894, 6441.581297215666], "unit": "score", "name": "mootools.html", "value": 4215.256357757893}, {"lowerIsBetter": false, "replicates": [304.7561950439648, 305.660716604569, 309.4445470380667, 309.6856690459183, 311.2297064764709, 5186.792528298868, 5277.050130976423, 5334.359876814778, 5353.491418315254, 5390.460953904608, 5224.92162617561, 5225.059489291926, 5253.080710875591, 5276.630635855492, 5278.524932756051, 3892.766434013968, 3975.7813320267373, 4078.714489985695, 4080.06158583526, 4108.8356465741335, 4072.796360181994, 4103.261412945669, 4106.7125301228925, 4109.815058322382, 4120.526139493952, 4065.9390109148385, 4069.674426045924, 4071.7353372030725, 4077.4903137107863, 4078.877633670995, 3845.365514690073, 3938.6258305460933, 4003.899902502432, 4011.7162507997455, 4016.518017837849, 3489.45913383426, 3498.247876706495, 3500.0199944015717, 3500.8949731508096, 3501.2122272488486, 5101.15830887903, 5105.795768169306, 5111.87220319495, 5115.7442127893455, 5116.386033675945, 4632.953670463286, 4635.374224479686, 4636.072785442925, 4636.698614590041, 4640.373549570799, 5575.553955683536, 5578.135389014709, 5578.916316255219, 5583.0, 5587.664740115565, 3810.9618903810883, 3811.27585758705, 3811.885643430674, 3813.180166264239, 3813.370793819044, 5615.46653067962, 5871.647701137946, 5873.882522349529, 5876.9118463223085, 5878.265216847852, 3878.9612103879163, 3905.023744063927, 3907.765534067965, 3908.6677632401565, 3910.4720862683744, 3961.643452089268, 3962.484876965976, 3963.781991990468, 3963.960360396417, 3965.8810235692977, 4596.724196548218, 4597.977010114995, 4598.540145985375, 4613.284940834176, 4613.3771940787565, 5574.526165275915, 5577.8047768327915, 5581.665100093926, 5582.748776305076, 5585.273914391184, 1378.63466181462, 1394.372532360442, 1395.141987677571, 1395.239594421043, 1398.8391334996402, 920.4615300049546, 938.474454305591, 954.8281309364243, 961.1829944547219, 963.0032915931977, 4779.713217206979, 4789.281607758794, 4790.0, 4814.085323788469, 4846.273059041101, 5687.800926967537, 5695.743691533891, 5712.285964254468, 5769.163471296639, 5771.163181338767, 4818.518148185153, 4820.566149046533, 4834.129856625841, 4835.734034628059, 4847.418309802846, 3058.250728571514, 3065.6014718086954, 3092.5515800208846, 3095.4273459409633, 3103.239706271933, 5423.2136340230445, 5429.0, 5429.0, 5431.158170483582, 5439.292891924025, 5733.397993210736, 5876.118582212703, 5887.911681324784, 5890.646561206341, 5890.764369425261, 5390.703511306838, 5397.433269506724, 5410.1343784994215, 5418.322709661293, 5427.402985671573, 5702.173184888085, 5706.229658996149, 5711.057675483498, 5716.256886604715, 5718.285214348207, 5579.525740311957, 5581.162825576033, 5581.916271255853, 5585.301837270341, 5588.748506317307, 5358.892822143457, 5386.946130538801, 5401.513863752281, 5405.3513578369275, 5407.513323800877, 3785.09157802131, 3859.498265225615, 3886.6113388660906, 3890.805459727059, 3892.9026774329736, 5550.58370622213, 5658.236138121301, 5688.203651488712, 5688.77244910199, 5695.829125126253, 5407.188921661782, 5467.58993075513, 5522.144067669517, 5581.023320918742, 5611.270534830609, 5563.248961390161, 5563.944360556343, 5573.665580065209, 5605.439456054362, 5606.607537472338, 5467.480589344006, 5475.342958844964, 5477.75350109238, 5480.780768769205, 5489.64317319373, 5620.213170156099, 5632.211490391266, 5643.097104463266, 5646.407127251579, 5647.632903861236, 5337.0, 5487.478689524489, 5495.2856128703015, 5497.8075767347955, 5509.438111278275], "unit": "score", "name": "prototype.html", "value": 4145.121865074689}, {"lowerIsBetter": false, "replicates": [658.9703463344149, 680.5542369747814, 750.5534207146749, 753.536575006371, 765.720512013115, 11718.472668729906, 11904.107191960606, 11905.940470297637, 11916.463759130838, 11921.344326062062, 13130.474781008772, 13392.330383480836, 13398.129121607113, 13416.865831341684, 13438.99207559432, 797.059469825607, 815.0789607743242, 815.9714409995652, 816.2082779703678, 816.9223923727236, 625.8435391152212, 790.8260182759784, 802.8675268580677, 812.7033632724073, 815.2499700275731, 848.893888263967, 850.3154960256991, 850.7235148576707, 851.085083535199, 851.2211326636151, 838.2539539809513, 844.025150950653, 844.9746507604751, 846.0693237438829, 846.496334680867, 479.45102857228625, 611.9357467465941, 619.4053708439903, 620.764109638339, 623.5915475363644, 12200.755984880252, 12211.206271592318, 12226.938865305705, 12280.324582147978, 12283.57007504733, 11288.322700637988, 11363.488643011084, 11482.311061336346, 11771.470283837249, 11935.283882966964, 9551.474668893208, 9607.663731769424, 9695.321327507078, 9703.07820757027, 9802.5588848502, 3153.668864769189, 3171.7938334008445, 3220.3237320162793, 3247.691469310412, 3293.275479394529, 39791.60208397908, 40166.59833401687, 40795.184096318204, 40801.0, 40933.59066409327, 9297.814043719087, 9370.578323975438, 9411.0, 9578.329516933887, 9674.371165874196, 16109.27508262131, 16114.274857631435, 16134.112623805804, 16228.594285142966, 16231.51305460838, 6246.906296405557, 6261.5616906816995, 6284.874302514016, 6391.872162556816, 6416.133821934072, 3550.840212190458, 3583.086312990171, 3612.1692010837655, 3653.9634603654154, 3731.7574357666663, 2667.3598336399514, 2714.8914043438435, 2715.592661100851, 2715.7555819976296, 2730.7678847297807, 467.88770695032946, 476.5044353872004, 479.60911856837265, 495.86611614863784, 498.04624144762374, 566.742132329789, 599.7151353107239, 616.7255571270741, 620.4199073865859, 628.0, 7194.15119403137, 7226.988221648973, 7359.742409015766, 7878.330341920886, 7931.325837303893, 604.9818505444844, 607.0954278125649, 618.6442795392667, 620.7423919073624, 626.1984659635674, 3458.4639380896, 3675.5956844747056, 3696.445533170046, 3758.2107757370713, 3829.100161462054, 47774.0, 48749.26876096861, 49009.509904901206, 49326.50673493291, 49328.0, 41245.793771030956, 42229.0, 42541.0, 45870.770646147226, 45896.770516147204, 41185.0, 41999.370009449885, 42051.36922946158, 42260.0, 43238.56761432345, 8255.463394879314, 8335.0, 8390.496570205807, 8445.268719912527, 8558.657653693783, 30151.547726783676, 30302.84848575743, 30512.542311864894, 30694.618742157105, 31228.219294517818, 35358.646413535535, 35381.169506438906, 36248.637513624526, 39310.80344598373, 39311.803440982614, 10696.465176741287, 10801.891981080404, 10939.124870010539, 10961.232713710282, 11112.833307500556, 10696.358218506915, 11069.446527673423, 11240.494177761857, 11245.918336778159, 11487.310761354345, 10471.0, 10657.25399222047, 10730.195235357223, 11023.393713345842, 11127.054200393057, 10473.214508912015, 10517.368957862553, 10897.400642964712, 10923.672289831318, 11350.489227984595, 10510.47447627631, 10685.626003089854, 10698.679039628823, 10747.570097196338, 11226.831597526207, 8851.867221991804, 8916.420432671855, 9113.270938325051, 9265.258779297505, 9420.528973551158, 9066.320025997944, 9113.453192808453, 9126.680566180152, 9140.085991400807, 9206.263498920205], "unit": "score", "name": "yui.html", "value": 5788.29330606994}], "name": "dromaeo_css", "value": 6113.746672155728}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 113.0, 107.0, 112.0, 113.0, 112.0, 101.0, 111.0, 112.0, 113.0], "unit": "score", "name": "ai-astar", "value": 110.4}, {"lowerIsBetter": true, "replicates": [159.0, 132.0, 154.0, 180.0, 134.0, 166.0, 155.0, 150.0, 177.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 153.7}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 163.0, 161.0, 162.0, 160.0, 164.0, 164.0, 162.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.2}, {"lowerIsBetter": true, "replicates": [75.0, 78.0, 112.0, 107.0, 74.0, 74.0, 74.0, 116.0, 94.0, 76.0], "unit": "score", "name": "audio-fft", "value": 88.0}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 137.0, 94.0, 96.0, 96.0, 145.0, 94.0, 95.0, 129.0], "unit": "score", "name": "audio-oscillator", "value": 107.7}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 118.0, 116.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.9}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 146.0, 147.0, 146.0, 145.0, 146.0, 147.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.3}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 97.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 68.0, 68.0, 68.0, 69.0, 70.0, 77.0, 66.0, 66.0], "unit": "score", "name": "json-parse-financial", "value": 69.0}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 70.0, 70.0, 70.0, 71.0, 70.0, 71.0, 70.0, 71.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 70.4}, {"lowerIsBetter": true, "replicates": [81.0, 83.0, 84.0, 83.0, 85.0, 82.0, 87.0, 82.0, 83.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.4}, {"lowerIsBetter": true, "replicates": [129.0, 123.0, 128.0, 118.0, 120.0, 120.0, 124.0, 122.0, 118.0, 129.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.1}, {"lowerIsBetter": true, "replicates": [165.0, 148.0, 152.0, 146.0, 152.0, 142.0, 145.0, 146.0, 145.0, 150.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.1}, {"lowerIsBetter": true, "replicates": [70.0, 72.0, 73.0, 72.0, 71.0, 71.0, 70.0, 71.0, 70.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.0}], "name": "kraken", "value": 1546.7}]} 06:11:33 INFO - Return code: 0 06:11:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:11:33 ERROR - # TBPL SUCCESS # 06:11:33 INFO - Running post-action listener: _resource_record_post_action 06:11:33 INFO - Running post-run listener: _resource_record_post_run 06:11:34 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 0; Write bytes: 528035840; Read time: 0; Write time: 493036 06:11:34 INFO - install - Wall time: 16s; CPU: 16.0%; Read bytes: 0; Write bytes: 240816128; Read time: 0; Write time: 299932 06:11:34 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 287219712; Read time: 0; Write time: 193104 06:11:34 INFO - Running post-run listener: _upload_blobber_files 06:11:34 INFO - Blob upload gear active. 06:11:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:11:34 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 06:11:34 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'] 06:11:34 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 06:11:34 INFO - (blobuploader) - INFO - Open directory for files ... 06:11:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:11:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:11:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:11:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:11:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:11:35 INFO - (blobuploader) - INFO - Done attempting. 06:11:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:11:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:11:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:11:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:11:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:11:36 INFO - (blobuploader) - INFO - Done attempting. 06:11:36 INFO - (blobuploader) - INFO - Iteration through files over. 06:11:36 INFO - Return code: 0 06:11:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:11:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:11:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fcd9fdd330fdb6e0ca2669b7c01bc3e1c8a7e6773ddb88fae18a5cda63f5eff0a1bb2f949c5a546cb7f5614b6bc2099193f61288fe64c2410bcc7d44abeaebd4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9713f905d44c7f38d9de6f10ad9c36203aaf03c4db574f21562d3961ee77743a03a5479f62af924d26bd663286f2a96656d1e01c403e21bde0b5a6cd036b8e24"} 06:11:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:11:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:11:36 INFO - Contents: 06:11:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fcd9fdd330fdb6e0ca2669b7c01bc3e1c8a7e6773ddb88fae18a5cda63f5eff0a1bb2f949c5a546cb7f5614b6bc2099193f61288fe64c2410bcc7d44abeaebd4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9713f905d44c7f38d9de6f10ad9c36203aaf03c4db574f21562d3961ee77743a03a5479f62af924d26bd663286f2a96656d1e01c403e21bde0b5a6cd036b8e24"} 06:11:36 INFO - Running post-run listener: copy_logs_to_upload_dir 06:11:36 INFO - Copying logs to upload dir... 06:11:36 INFO - mkdir: /builds/slave/test/build/upload/logs 06:11:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.676073 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-03-09 06:11:36.175438) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-09 06:11:36.179448) ========= 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=652eb03db935cfc1c15ebda0000001ad-1457527862.890856-1945449351 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/fcd9fdd330fdb6e0ca2669b7c01bc3e1c8a7e6773ddb88fae18a5cda63f5eff0a1bb2f949c5a546cb7f5614b6bc2099193f61288fe64c2410bcc7d44abeaebd4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9713f905d44c7f38d9de6f10ad9c36203aaf03c4db574f21562d3961ee77743a03a5479f62af924d26bd663286f2a96656d1e01c403e21bde0b5a6cd036b8e24"} build_url:https://queue.taskcluster.net/v1/task/BD3ZawAwRsWScJO1G9NqHA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011254 build_url: 'https://queue.taskcluster.net/v1/task/BD3ZawAwRsWScJO1G9NqHA/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/fcd9fdd330fdb6e0ca2669b7c01bc3e1c8a7e6773ddb88fae18a5cda63f5eff0a1bb2f949c5a546cb7f5614b6bc2099193f61288fe64c2410bcc7d44abeaebd4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9713f905d44c7f38d9de6f10ad9c36203aaf03c4db574f21562d3961ee77743a03a5479f62af924d26bd663286f2a96656d1e01c403e21bde0b5a6cd036b8e24"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-09 06:11:36.204087) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 06:11:36.204445) ========= 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=652eb03db935cfc1c15ebda0000001ad-1457527862.890856-1945449351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004430 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-09 06:11:36.289697) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-09 06:11:36.290067) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-09 06:11:36.290430) ========= ========= Total master_lag: 0.31 =========