builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-012 starttime: 1464761350.06 results: success (0) buildid: 20160531203041 builduid: 0a0abc26a1594fcdb3452b26fa1e7878 revision: 933c4c92752c3a9f51421d75ec9946642cc49dc2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-31 23:09:10.059216) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-31 23:09:10.059741) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-31 23:09:10.060276) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-31 23:09:10.363229) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 23:09:10.363494) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1464759983.559522-856082644 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-31 23:09:10-- 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% 32.5M=0s 2016-05-31 23:09:10 (32.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.109255 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 23:09:10.491034) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 23:09:10.491329) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', '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=2c5dd2b0a310ecf02fd87158000001b4-1464759983.559522-856082644 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014622 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 23:09:10.548150) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 23:09:10.548458) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 933c4c92752c3a9f51421d75ec9946642cc49dc2 --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 933c4c92752c3a9f51421d75ec9946642cc49dc2 --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=2c5dd2b0a310ecf02fd87158000001b4-1464759983.559522-856082644 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-31 23:09:10,745 truncating revision to first 12 chars 2016-05-31 23:09:10,745 Setting DEBUG logging. 2016-05-31 23:09:10,745 attempt 1/10 2016-05-31 23:09:10,745 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/933c4c92752c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-31 23:09:11,247 unpacking tar archive at: fx-team-933c4c92752c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.813784 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 23:09:11.394903) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-31 23:09:11.395819) ========= script_repo_revision: 933c4c92752c3a9f51421d75ec9946642cc49dc2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-31 23:09:11.396742) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-31 23:09:11.397586) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-31 23:09:11.410067) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-05-31 23:09:11.410802) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=2c5dd2b0a310ecf02fd87158000001b4-1464759983.559522-856082644 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:09:11 INFO - MultiFileLogger online at 20160531 23:09:11 in /builds/slave/test 23:09:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 23:09:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:09:11 INFO - {'append_to_log': False, 23:09:11 INFO - 'base_work_dir': '/builds/slave/test', 23:09:11 INFO - 'blob_upload_branch': 'Fx-Team', 23:09:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:09:11 INFO - 'branch': 'Fx-Team', 23:09:11 INFO - 'buildbot_json_path': 'buildprops.json', 23:09:11 INFO - 'config_files': ('talos/linux_config.py',), 23:09:11 INFO - 'default_actions': ('clobber', 23:09:11 INFO - 'read-buildbot-config', 23:09:11 INFO - 'download-and-extract', 23:09:11 INFO - 'populate-webroot', 23:09:11 INFO - 'create-virtualenv', 23:09:11 INFO - 'install', 23:09:11 INFO - 'run-tests'), 23:09:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:09:11 INFO - 'download_minidump_stackwalk': True, 23:09:11 INFO - 'download_symbols': 'ondemand', 23:09:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:09:11 INFO - 'tooltool.py': '/tools/tooltool.py', 23:09:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:09:11 INFO - '/tools/misc-python/virtualenv.py')}, 23:09:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:09:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:09:11 INFO - 'installer_path': 'installer.exe', 23:09:11 INFO - 'log_level': 'info', 23:09:11 INFO - 'log_name': 'talos', 23:09:11 INFO - 'log_to_console': True, 23:09:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:09:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:09:11 INFO - 'opt_config_files': (), 23:09:11 INFO - 'pip_index': False, 23:09:11 INFO - 'sps_profile': False, 23:09:11 INFO - 'sps_profile_interval': 0, 23:09:11 INFO - 'suite': 'dromaeojs', 23:09:11 INFO - 'system_bits': '32', 23:09:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:09:11 INFO - 'title': 'talos-linux64-ix-012', 23:09:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:09:11 INFO - 'use_talos_json': True, 23:09:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:09:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:09:11 INFO - 'work_dir': 'build'} 23:09:11 INFO - ##### 23:09:11 INFO - ##### Running clobber step. 23:09:11 INFO - ##### 23:09:11 INFO - Running pre-action listener: _resource_record_pre_action 23:09:11 INFO - Running main action method: clobber 23:09:11 INFO - rmtree: /builds/slave/test/build 23:09:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:09:12 INFO - Running post-action listener: _resource_record_post_action 23:09:12 INFO - ##### 23:09:12 INFO - ##### Finished clobber step (success) 23:09:12 INFO - ##### 23:09:12 INFO - ##### 23:09:12 INFO - ##### Running read-buildbot-config step. 23:09:12 INFO - ##### 23:09:12 INFO - Running pre-action listener: _resource_record_pre_action 23:09:12 INFO - Running main action method: read_buildbot_config 23:09:12 INFO - Using buildbot properties: 23:09:12 INFO - { 23:09:12 INFO - "project": "", 23:09:12 INFO - "product": "firefox", 23:09:12 INFO - "script_repo_revision": "production", 23:09:12 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 23:09:12 INFO - "repository": "", 23:09:12 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 23:09:12 INFO - "buildid": "20160531203041", 23:09:12 INFO - "pgo_build": "True", 23:09:12 INFO - "basedir": "/builds/slave/test", 23:09:12 INFO - "buildnumber": 1209, 23:09:12 INFO - "slavename": "talos-linux64-ix-012", 23:09:12 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 23:09:12 INFO - "platform": "ubuntu64_hw", 23:09:12 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:09:12 INFO - "branch": "fx-team", 23:09:12 INFO - "repo_path": "integration/fx-team", 23:09:12 INFO - "revision": "933c4c92752c3a9f51421d75ec9946642cc49dc2", 23:09:12 INFO - "stage_platform": "linux64-pgo", 23:09:12 INFO - "builduid": "0a0abc26a1594fcdb3452b26fa1e7878", 23:09:12 INFO - "slavebuilddir": "test" 23:09:12 INFO - } 23:09:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/RYuzWjGEQ76cjRlV_AQgEQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 23:09:12 INFO - Running post-action listener: _resource_record_post_action 23:09:12 INFO - ##### 23:09:12 INFO - ##### Finished read-buildbot-config step (success) 23:09:12 INFO - ##### 23:09:12 INFO - ##### 23:09:12 INFO - ##### Running download-and-extract step. 23:09:12 INFO - ##### 23:09:12 INFO - Running pre-action listener: _resource_record_pre_action 23:09:12 INFO - Running main action method: download_and_extract 23:09:12 INFO - mkdir: /builds/slave/test/build/tests 23:09:12 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')]} 23:09:12 INFO - https://queue.taskcluster.net/v1/task/RYuzWjGEQ76cjRlV_AQgEQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:09:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RYuzWjGEQ76cjRlV_AQgEQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:09:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RYuzWjGEQ76cjRlV_AQgEQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:09:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RYuzWjGEQ76cjRlV_AQgEQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:09:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RYuzWjGEQ76cjRlV_AQgEQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 23:09:12 INFO - Downloaded 1361 bytes. 23:09:12 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:09:12 INFO - Using the following test package requirements: 23:09:12 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 23:09:12 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:12 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:09:12 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:12 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:09:12 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:12 INFO - u'jsshell-linux-x86_64.zip'], 23:09:12 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:12 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:09:12 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 23:09:12 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:12 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:09:12 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:12 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:09:12 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:12 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:09:12 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:12 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:09:12 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:09:12 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')]} 23:09:12 INFO - https://queue.taskcluster.net/v1/task/RYuzWjGEQ76cjRlV_AQgEQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:09:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RYuzWjGEQ76cjRlV_AQgEQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:09:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RYuzWjGEQ76cjRlV_AQgEQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:09:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RYuzWjGEQ76cjRlV_AQgEQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:09:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RYuzWjGEQ76cjRlV_AQgEQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:09:14 INFO - Downloaded 24413111 bytes. 23:09:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:09:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:09:15 INFO - Return code: 0 23:09:15 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 23:09: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')]} 23:09:15 INFO - https://queue.taskcluster.net/v1/task/RYuzWjGEQ76cjRlV_AQgEQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:09:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RYuzWjGEQ76cjRlV_AQgEQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:09:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RYuzWjGEQ76cjRlV_AQgEQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:09:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RYuzWjGEQ76cjRlV_AQgEQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:09:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RYuzWjGEQ76cjRlV_AQgEQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:09:38 INFO - Downloaded 24413111 bytes. 23:09:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:09:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:09:39 INFO - Return code: 0 23:09:39 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')]} 23:09:39 INFO - https://queue.taskcluster.net/v1/task/RYuzWjGEQ76cjRlV_AQgEQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:09:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RYuzWjGEQ76cjRlV_AQgEQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 23:09:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RYuzWjGEQ76cjRlV_AQgEQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 23:09:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RYuzWjGEQ76cjRlV_AQgEQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 23:09:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RYuzWjGEQ76cjRlV_AQgEQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:09:40 INFO - Downloaded 10834055 bytes. 23:09:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:09:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 23:09:41 INFO - Return code: 0 23:09:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:41 INFO - https://queue.taskcluster.net/v1/task/RYuzWjGEQ76cjRlV_AQgEQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:09:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RYuzWjGEQ76cjRlV_AQgEQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:09:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RYuzWjGEQ76cjRlV_AQgEQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:09:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RYuzWjGEQ76cjRlV_AQgEQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:09:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RYuzWjGEQ76cjRlV_AQgEQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 23:09:43 INFO - Downloaded 58975655 bytes. 23:09:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RYuzWjGEQ76cjRlV_AQgEQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:09:43 INFO - mkdir: /builds/slave/test/properties 23:09:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:09:43 INFO - Writing to file /builds/slave/test/properties/build_url 23:09:43 INFO - Contents: 23:09:43 INFO - build_url:https://queue.taskcluster.net/v1/task/RYuzWjGEQ76cjRlV_AQgEQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:09:44 INFO - Running post-action listener: _resource_record_post_action 23:09:44 INFO - Running post-action listener: set_extra_try_arguments 23:09:44 INFO - ##### 23:09:44 INFO - ##### Finished download-and-extract step (success) 23:09:44 INFO - ##### 23:09:44 INFO - ##### 23:09:44 INFO - ##### Running populate-webroot step. 23:09:44 INFO - ##### 23:09:44 INFO - Running pre-action listener: _resource_record_pre_action 23:09:44 INFO - Running main action method: populate_webroot 23:09:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:09:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:09:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:09:44 INFO - '--tppagecycles', 23:09:44 INFO - '7'], 23:09:44 INFO - 'tests': ['tsvgm']}}, 23:09:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:09:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:09:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:09:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:09:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:09:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:09:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:44 INFO - 'talos_options': ['--disable-e10s'], 23:09:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:09:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:09:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:44 INFO - 'talos_options': ['--disable-e10s'], 23:09:44 INFO - 'tests': ['damp', 'tps']}, 23:09:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:44 INFO - 'tests': ['damp', 'tps']}, 23:09:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:09:44 INFO - 'tests': ['dromaeo_dom']}, 23:09:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:09:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:09:44 INFO - 'tests': ['a11yr', 23:09:44 INFO - 'ts_paint', 23:09:44 INFO - 'tpaint', 23:09:44 INFO - 'sessionrestore', 23:09:44 INFO - 'sessionrestore_no_auto_restore', 23:09:44 INFO - 'tabpaint']}, 23:09:44 INFO - 'other-e10s': {'tests': ['a11yr', 23:09:44 INFO - 'ts_paint', 23:09:44 INFO - 'tpaint', 23:09:44 INFO - 'sessionrestore', 23:09:44 INFO - 'sessionrestore_no_auto_restore', 23:09:44 INFO - 'tabpaint']}, 23:09:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:09:44 INFO - 'ts_paint', 23:09:44 INFO - 'tpaint', 23:09:44 INFO - 'sessionrestore', 23:09:44 INFO - 'sessionrestore_no_auto_restore', 23:09:44 INFO - 'tabpaint']}, 23:09:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:09:44 INFO - 'ts_paint', 23:09:44 INFO - 'tpaint', 23:09:44 INFO - 'sessionrestore', 23:09:44 INFO - 'sessionrestore_no_auto_restore', 23:09:44 INFO - 'tabpaint']}, 23:09:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:09:44 INFO - 'tests': ['a11yr', 23:09:44 INFO - 'ts_paint', 23:09:44 INFO - 'tpaint', 23:09:44 INFO - 'sessionrestore', 23:09:44 INFO - 'sessionrestore_no_auto_restore', 23:09:44 INFO - 'tabpaint']}, 23:09:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:09:44 INFO - 'tests': ['a11yr', 23:09:44 INFO - 'ts_paint', 23:09:44 INFO - 'tpaint', 23:09:44 INFO - 'sessionrestore', 23:09:44 INFO - 'sessionrestore_no_auto_restore', 23:09:44 INFO - 'tabpaint']}, 23:09:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:09:44 INFO - 'tests': ['tsvgx', 23:09:44 INFO - 'tsvgr_opacity', 23:09:44 INFO - 'tart', 23:09:44 INFO - 'tscrollx', 23:09:44 INFO - 'cart']}, 23:09:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:09:44 INFO - 'tsvgr_opacity', 23:09:44 INFO - 'tart', 23:09:44 INFO - 'tscrollx', 23:09:44 INFO - 'cart']}, 23:09:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:44 INFO - 'talos_options': ['--disable-e10s'], 23:09:44 INFO - 'tests': ['tp5o']}, 23:09:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:44 INFO - 'tests': ['tp5o']}, 23:09:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:44 INFO - 'talos_options': ['--disable-e10s', 23:09:44 INFO - '--xperf_path', 23:09:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:09:44 INFO - 'tests': ['tp5n']}, 23:09:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:44 INFO - 'talos_options': ['--xperf_path', 23:09:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:09:44 INFO - 'tests': ['tp5n']}}, 23:09:44 INFO - 'talos.zip': {'path': '', 23:09:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:09:44 INFO - Running post-action listener: _resource_record_post_action 23:09:44 INFO - ##### 23:09:44 INFO - ##### Finished populate-webroot step (success) 23:09:44 INFO - ##### 23:09:44 INFO - ##### 23:09:44 INFO - ##### Running create-virtualenv step. 23:09:44 INFO - ##### 23:09:44 INFO - Running pre-action listener: _resource_record_pre_action 23:09:44 INFO - Running main action method: create_virtualenv 23:09:44 INFO - Creating virtualenv /builds/slave/test/build/venv 23:09:44 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 23:09:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:09:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:09:45 INFO - Using real prefix '/usr' 23:09:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:09:45 INFO - Installing distribute.............................................................................................................................................................................................done. 23:09:47 INFO - Installing pip.................done. 23:09:47 INFO - Return code: 0 23:09:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:09:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97a75c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x211c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21e7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22769c0>, '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 0x22778c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2277d50>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1464759983.559522-856082644', '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 23:09:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:09:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:09:47 INFO - Using env: {'DISPLAY': ':0', 23:09:47 INFO - 'HOME': '/home/cltbld', 23:09:47 INFO - 'LANG': 'en_US.UTF-8', 23:09:47 INFO - 'LANGUAGE': 'en_US:en', 23:09:47 INFO - 'LOGNAME': 'cltbld', 23:09:47 INFO - 'MAIL': '/var/mail/cltbld', 23:09:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:47 INFO - 'MOZ_NO_REMOTE': '1', 23:09:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:47 INFO - 'NO_EM_RESTART': '1', 23:09:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:47 INFO - 'PWD': '/builds/slave/test', 23:09:47 INFO - 'SHELL': '/bin/bash', 23:09:47 INFO - 'SHLVL': '1', 23:09:47 INFO - 'TERM': 'linux', 23:09:47 INFO - 'TMOUT': '86400', 23:09:47 INFO - 'USER': 'cltbld', 23:09:47 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464759983.559522-856082644', 23:09:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:47 INFO - '_': '/tools/buildbot/bin/python'} 23:09:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:47 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 23:09:47 INFO - Cleaning up... 23:09:47 INFO - Return code: 0 23:09:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:09:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97a75c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x211c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21e7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22769c0>, '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 0x22778c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2277d50>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1464759983.559522-856082644', '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 23:09:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 23:09:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 23:09:47 INFO - Using env: {'DISPLAY': ':0', 23:09:47 INFO - 'HOME': '/home/cltbld', 23:09:47 INFO - 'LANG': 'en_US.UTF-8', 23:09:47 INFO - 'LANGUAGE': 'en_US:en', 23:09:47 INFO - 'LOGNAME': 'cltbld', 23:09:47 INFO - 'MAIL': '/var/mail/cltbld', 23:09:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:47 INFO - 'MOZ_NO_REMOTE': '1', 23:09:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:47 INFO - 'NO_EM_RESTART': '1', 23:09:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:47 INFO - 'PWD': '/builds/slave/test', 23:09:47 INFO - 'SHELL': '/bin/bash', 23:09:47 INFO - 'SHLVL': '1', 23:09:47 INFO - 'TERM': 'linux', 23:09:47 INFO - 'TMOUT': '86400', 23:09:47 INFO - 'USER': 'cltbld', 23:09:47 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464759983.559522-856082644', 23:09:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:47 INFO - '_': '/tools/buildbot/bin/python'} 23:09:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:47 INFO - Downloading/unpacking psutil>=3.1.1 23:09:47 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 23:09:47 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 23:09:47 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 23:09:47 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 23:09:47 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 23:09:47 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 23:09:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:09:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:09:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:09:50 INFO - Installing collected packages: psutil 23:09:50 INFO - Running setup.py install for psutil 23:09:50 INFO - building 'psutil._psutil_linux' extension 23:09:50 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 23:09:50 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 23:09:50 INFO - building 'psutil._psutil_posix' extension 23:09:50 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 23:09:50 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 23:09:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:09:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:09:50 INFO - Successfully installed psutil 23:09:50 INFO - Cleaning up... 23:09:50 INFO - Return code: 0 23:09:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:09:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97a75c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x211c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21e7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22769c0>, '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 0x22778c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2277d50>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1464759983.559522-856082644', '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 23:09:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 23:09:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 23:09:50 INFO - Using env: {'DISPLAY': ':0', 23:09:50 INFO - 'HOME': '/home/cltbld', 23:09:50 INFO - 'LANG': 'en_US.UTF-8', 23:09:50 INFO - 'LANGUAGE': 'en_US:en', 23:09:50 INFO - 'LOGNAME': 'cltbld', 23:09:50 INFO - 'MAIL': '/var/mail/cltbld', 23:09:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:50 INFO - 'MOZ_NO_REMOTE': '1', 23:09:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:50 INFO - 'NO_EM_RESTART': '1', 23:09:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:50 INFO - 'PWD': '/builds/slave/test', 23:09:50 INFO - 'SHELL': '/bin/bash', 23:09:50 INFO - 'SHLVL': '1', 23:09:50 INFO - 'TERM': 'linux', 23:09:50 INFO - 'TMOUT': '86400', 23:09:50 INFO - 'USER': 'cltbld', 23:09:50 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464759983.559522-856082644', 23:09:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:50 INFO - '_': '/tools/buildbot/bin/python'} 23:09:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:09:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:09:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:09:52 INFO - Installing collected packages: mozsystemmonitor 23:09:52 INFO - Running setup.py install for mozsystemmonitor 23:09:52 INFO - Successfully installed mozsystemmonitor 23:09:52 INFO - Cleaning up... 23:09:52 INFO - Return code: 0 23:09:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:09:52 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')]} 23:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:52 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')]} 23:09:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:52 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 0x7f97a75c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x211c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21e7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22769c0>, '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 0x22778c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2277d50>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1464759983.559522-856082644', '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 23:09:52 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 23:09:52 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 23:09:52 INFO - Using env: {'DISPLAY': ':0', 23:09:52 INFO - 'HOME': '/home/cltbld', 23:09:52 INFO - 'LANG': 'en_US.UTF-8', 23:09:52 INFO - 'LANGUAGE': 'en_US:en', 23:09:52 INFO - 'LOGNAME': 'cltbld', 23:09:52 INFO - 'MAIL': '/var/mail/cltbld', 23:09:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:52 INFO - 'MOZ_NO_REMOTE': '1', 23:09:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:52 INFO - 'NO_EM_RESTART': '1', 23:09:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:52 INFO - 'PWD': '/builds/slave/test', 23:09:52 INFO - 'SHELL': '/bin/bash', 23:09:52 INFO - 'SHLVL': '1', 23:09:52 INFO - 'TERM': 'linux', 23:09:52 INFO - 'TMOUT': '86400', 23:09:52 INFO - 'USER': 'cltbld', 23:09:52 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464759983.559522-856082644', 23:09:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:52 INFO - '_': '/tools/buildbot/bin/python'} 23:09:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:53 INFO - Downloading/unpacking blobuploader==1.2.4 23:09:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:09:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:09:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:09:54 INFO - Downloading blobuploader-1.2.4.tar.gz 23:09:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:09:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:09:55 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 23:09:55 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 23:09:55 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 23:09:55 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 23:09:55 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 23:09:55 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 23:09:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:09:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:09:55 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 23:09:55 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 23:09:55 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 23:09:55 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 23:09:55 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 23:09:55 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 23:09:55 INFO - Downloading docopt-0.6.1.tar.gz 23:09:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:09:55 INFO - Installing collected packages: blobuploader, requests, docopt 23:09:55 INFO - Running setup.py install for blobuploader 23:09:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:09:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:09:55 INFO - Running setup.py install for requests 23:09:56 INFO - Running setup.py install for docopt 23:09:56 INFO - Successfully installed blobuploader requests docopt 23:09:56 INFO - Cleaning up... 23:09:56 INFO - Return code: 0 23:09:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:09:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:56 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 0x7f97a75c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x211c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21e7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22769c0>, '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 0x22778c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2277d50>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1464759983.559522-856082644', '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 23:09:56 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 23:09:56 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 23:09:56 INFO - Using env: {'DISPLAY': ':0', 23:09:56 INFO - 'HOME': '/home/cltbld', 23:09:56 INFO - 'LANG': 'en_US.UTF-8', 23:09:56 INFO - 'LANGUAGE': 'en_US:en', 23:09:56 INFO - 'LOGNAME': 'cltbld', 23:09:56 INFO - 'MAIL': '/var/mail/cltbld', 23:09:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:56 INFO - 'MOZ_NO_REMOTE': '1', 23:09:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:56 INFO - 'NO_EM_RESTART': '1', 23:09:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:56 INFO - 'PWD': '/builds/slave/test', 23:09:56 INFO - 'SHELL': '/bin/bash', 23:09:56 INFO - 'SHLVL': '1', 23:09:56 INFO - 'TERM': 'linux', 23:09:56 INFO - 'TMOUT': '86400', 23:09:56 INFO - 'USER': 'cltbld', 23:09:56 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464759983.559522-856082644', 23:09:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:56 INFO - '_': '/tools/buildbot/bin/python'} 23:09:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:09:56 INFO - Running setup.py (path:/tmp/pip-BRdwQE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:09:56 INFO - Running setup.py (path:/tmp/pip-XYC0dF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:09:56 INFO - Running setup.py (path:/tmp/pip-FYazgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:09:56 INFO - Running setup.py (path:/tmp/pip-jVfyBy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:09:56 INFO - Running setup.py (path:/tmp/pip-cmC8eb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:09:56 INFO - Running setup.py (path:/tmp/pip-4qZSZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:09:56 INFO - Running setup.py (path:/tmp/pip-4bSrus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:09:57 INFO - Running setup.py (path:/tmp/pip-KVrAx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:09:57 INFO - Running setup.py (path:/tmp/pip-vtNCm_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:09:57 INFO - Running setup.py (path:/tmp/pip-qzRfSL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:09:57 INFO - Running setup.py (path:/tmp/pip-E289xl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:09:57 INFO - Running setup.py (path:/tmp/pip-B5YPOK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:09:57 INFO - Running setup.py (path:/tmp/pip-Xyf56R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:09:57 INFO - Running setup.py (path:/tmp/pip-vn9sXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:09:57 INFO - Running setup.py (path:/tmp/pip-gHX6Er-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:09:57 INFO - Running setup.py (path:/tmp/pip-dIIFgQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:09:57 INFO - Running setup.py (path:/tmp/pip-QXBA6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:09:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:09:57 INFO - Running setup.py install for manifestparser 23:09:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:09:57 INFO - Running setup.py install for mozcrash 23:09:57 INFO - Running setup.py install for mozdebug 23:09:58 INFO - Running setup.py install for mozdevice 23:09:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:09:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:09:58 INFO - Running setup.py install for mozfile 23:09:58 INFO - Running setup.py install for mozhttpd 23:09:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:09:58 INFO - Running setup.py install for mozinfo 23:09:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:09:58 INFO - Running setup.py install for mozInstall 23:09:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:09:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:09:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:09:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:09:58 INFO - Running setup.py install for mozleak 23:09:58 INFO - Running setup.py install for mozlog 23:09:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:09:58 INFO - Running setup.py install for moznetwork 23:09:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:09:58 INFO - Running setup.py install for mozprocess 23:09:58 INFO - Running setup.py install for mozprofile 23:09:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:09:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:09:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:09:59 INFO - Running setup.py install for mozrunner 23:09:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:09:59 INFO - Running setup.py install for mozscreenshot 23:09:59 INFO - Running setup.py install for moztest 23:09:59 INFO - Running setup.py install for mozversion 23:09:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:09:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:09:59 INFO - Cleaning up... 23:09:59 INFO - Return code: 0 23:09:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:09:59 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')]} 23:09:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:59 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')]} 23:09:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:59 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 0x7f97a75c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x211c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21e7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22769c0>, '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 0x22778c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2277d50>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1464759983.559522-856082644', '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 23:09:59 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 23:09:59 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 23:09:59 INFO - Using env: {'DISPLAY': ':0', 23:09:59 INFO - 'HOME': '/home/cltbld', 23:09:59 INFO - 'LANG': 'en_US.UTF-8', 23:09:59 INFO - 'LANGUAGE': 'en_US:en', 23:09:59 INFO - 'LOGNAME': 'cltbld', 23:09:59 INFO - 'MAIL': '/var/mail/cltbld', 23:09:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:59 INFO - 'MOZ_NO_REMOTE': '1', 23:09:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:59 INFO - 'NO_EM_RESTART': '1', 23:09:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:59 INFO - 'PWD': '/builds/slave/test', 23:09:59 INFO - 'SHELL': '/bin/bash', 23:09:59 INFO - 'SHLVL': '1', 23:09:59 INFO - 'TERM': 'linux', 23:09:59 INFO - 'TMOUT': '86400', 23:09:59 INFO - 'USER': 'cltbld', 23:09:59 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464759983.559522-856082644', 23:09:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:59 INFO - '_': '/tools/buildbot/bin/python'} 23:09:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:09:59 INFO - Running setup.py (path:/tmp/pip-q3F0c5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:09:59 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)) 23:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:09:59 INFO - Running setup.py (path:/tmp/pip-cOFqXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:09:59 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)) 23:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:09:59 INFO - Running setup.py (path:/tmp/pip-MFFfGH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:09:59 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)) 23:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:09:59 INFO - Running setup.py (path:/tmp/pip-FxSauS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:10:00 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)) 23:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:10:00 INFO - Running setup.py (path:/tmp/pip-FiLCSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:10:00 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)) 23:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:10:00 INFO - Running setup.py (path:/tmp/pip-_Zwk4I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:10:00 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)) 23:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:10:00 INFO - Running setup.py (path:/tmp/pip-BTl5yP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:10:00 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)) 23:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:10:00 INFO - Running setup.py (path:/tmp/pip-0WbVg_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:10:00 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)) 23:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:10:00 INFO - Running setup.py (path:/tmp/pip-9QD6pM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:10:00 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)) 23:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:10:00 INFO - Running setup.py (path:/tmp/pip-6V9iII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:10:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 23:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:10:00 INFO - Running setup.py (path:/tmp/pip-3j02_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:10:00 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)) 23:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:10:00 INFO - Running setup.py (path:/tmp/pip-G3cxaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:10:00 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)) 23:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:10:00 INFO - Running setup.py (path:/tmp/pip-SYngN3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:10:00 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)) 23:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:10:00 INFO - Running setup.py (path:/tmp/pip-zfMmjx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:10:00 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)) 23:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:10:00 INFO - Running setup.py (path:/tmp/pip-gHRhPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:10:00 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)) 23:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:10:00 INFO - Running setup.py (path:/tmp/pip-pWYkH7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:10:00 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)) 23:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:10:00 INFO - Running setup.py (path:/tmp/pip-RqD_y4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:10:00 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)) 23:10:00 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)) 23:10:00 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)) 23:10:00 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)) 23:10:00 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)) 23:10:00 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)) 23:10:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:10:00 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 23:10:00 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 23:10:00 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 23:10:00 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 23:10:00 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 23:10:00 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 23:10:02 INFO - Downloading blessings-1.6.tar.gz 23:10:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:10:02 INFO - Installing collected packages: blessings 23:10:02 INFO - Running setup.py install for blessings 23:10:03 INFO - Successfully installed blessings 23:10:03 INFO - Cleaning up... 23:10:03 INFO - Return code: 0 23:10:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:10:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:10:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:10:03 INFO - Reading from file tmpfile_stdout 23:10:03 INFO - Current package versions: 23:10:03 INFO - argparse == 1.2.1 23:10:03 INFO - blessings == 1.6 23:10:03 INFO - blobuploader == 1.2.4 23:10:03 INFO - docopt == 0.6.1 23:10:03 INFO - manifestparser == 1.1 23:10:03 INFO - mozInstall == 1.12 23:10:03 INFO - mozcrash == 0.17 23:10:03 INFO - mozdebug == 0.1 23:10:03 INFO - mozdevice == 0.48 23:10:03 INFO - mozfile == 1.2 23:10:03 INFO - mozhttpd == 0.7 23:10:03 INFO - mozinfo == 0.9 23:10:03 INFO - mozleak == 0.1 23:10:03 INFO - mozlog == 3.2 23:10:03 INFO - moznetwork == 0.27 23:10:03 INFO - mozprocess == 0.22 23:10:03 INFO - mozprofile == 0.28 23:10:03 INFO - mozrunner == 6.11 23:10:03 INFO - mozscreenshot == 0.1 23:10:03 INFO - mozsystemmonitor == 0.3 23:10:03 INFO - moztest == 0.7 23:10:03 INFO - mozversion == 1.4 23:10:03 INFO - psutil == 3.1.1 23:10:03 INFO - requests == 1.2.3 23:10:03 INFO - wsgiref == 0.1.2 23:10:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:10: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')]} 23:10:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:10:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10: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')]} 23:10:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:10:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:03 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 0x7f97a75c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x211c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21e7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22769c0>, '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 0x22778c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2277d50>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1464759983.559522-856082644', '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 23:10:03 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 23:10:03 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 23:10:03 INFO - Using env: {'DISPLAY': ':0', 23:10:03 INFO - 'HOME': '/home/cltbld', 23:10:03 INFO - 'LANG': 'en_US.UTF-8', 23:10:03 INFO - 'LANGUAGE': 'en_US:en', 23:10:03 INFO - 'LOGNAME': 'cltbld', 23:10:03 INFO - 'MAIL': '/var/mail/cltbld', 23:10:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:03 INFO - 'MOZ_NO_REMOTE': '1', 23:10:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:10:03 INFO - 'NO_EM_RESTART': '1', 23:10:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:10:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:10:03 INFO - 'PWD': '/builds/slave/test', 23:10:03 INFO - 'SHELL': '/bin/bash', 23:10:03 INFO - 'SHLVL': '1', 23:10:03 INFO - 'TERM': 'linux', 23:10:03 INFO - 'TMOUT': '86400', 23:10:03 INFO - 'USER': 'cltbld', 23:10:03 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464759983.559522-856082644', 23:10:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:03 INFO - '_': '/tools/buildbot/bin/python'} 23:10:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:10:03 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)) 23:10:03 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)) 23:10:03 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)) 23:10:03 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)) 23:10:03 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)) 23:10:03 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)) 23:10:03 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)) 23:10:03 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)) 23:10:03 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)) 23:10:03 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)) 23:10:03 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)) 23:10:03 INFO - Cleaning up... 23:10:03 INFO - Return code: 0 23:10:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:10: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')]} 23:10:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:10:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10: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')]} 23:10:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:10:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97a75c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x211c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21e7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22769c0>, '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 0x22778c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2277d50>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1464759983.559522-856082644', '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 23:10:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 23:10:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:10:03 INFO - Using env: {'DISPLAY': ':0', 23:10:03 INFO - 'HOME': '/home/cltbld', 23:10:03 INFO - 'LANG': 'en_US.UTF-8', 23:10:03 INFO - 'LANGUAGE': 'en_US:en', 23:10:03 INFO - 'LOGNAME': 'cltbld', 23:10:03 INFO - 'MAIL': '/var/mail/cltbld', 23:10:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:03 INFO - 'MOZ_NO_REMOTE': '1', 23:10:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:10:03 INFO - 'NO_EM_RESTART': '1', 23:10:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:10:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:10:03 INFO - 'PWD': '/builds/slave/test', 23:10:03 INFO - 'SHELL': '/bin/bash', 23:10:03 INFO - 'SHLVL': '1', 23:10:03 INFO - 'TERM': 'linux', 23:10:03 INFO - 'TMOUT': '86400', 23:10:03 INFO - 'USER': 'cltbld', 23:10:03 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464759983.559522-856082644', 23:10:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:03 INFO - '_': '/tools/buildbot/bin/python'} 23:10:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:10:03 INFO - Downloading/unpacking jsonschema 23:10:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:10:05 INFO - Downloading/unpacking functools32 (from jsonschema) 23:10:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:05 INFO - Downloading functools32-3.2.3-2.tar.gz 23:10:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:10:05 INFO - warning: no files found matching '*.txt' 23:10:05 INFO - no previously-included directories found matching 'build' 23:10:05 INFO - no previously-included directories found matching 'dist' 23:10:05 INFO - no previously-included directories found matching '.git*' 23:10:05 INFO - Installing collected packages: jsonschema, functools32 23:10:05 INFO - Running setup.py install for functools32 23:10:06 INFO - warning: no files found matching '*.txt' 23:10:06 INFO - no previously-included directories found matching 'build' 23:10:06 INFO - no previously-included directories found matching 'dist' 23:10:06 INFO - no previously-included directories found matching '.git*' 23:10:06 INFO - Successfully installed jsonschema functools32 23:10:06 INFO - Cleaning up... 23:10:06 INFO - Return code: 0 23:10:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:10:06 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')]} 23:10:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:10:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:06 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')]} 23:10:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:10:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:06 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 0x7f97a75c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x211c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21e7770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22769c0>, '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 0x22778c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2277d50>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1464759983.559522-856082644', '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 23:10:06 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 23:10:06 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 23:10:06 INFO - Using env: {'DISPLAY': ':0', 23:10:06 INFO - 'HOME': '/home/cltbld', 23:10:06 INFO - 'LANG': 'en_US.UTF-8', 23:10:06 INFO - 'LANGUAGE': 'en_US:en', 23:10:06 INFO - 'LOGNAME': 'cltbld', 23:10:06 INFO - 'MAIL': '/var/mail/cltbld', 23:10:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:06 INFO - 'MOZ_NO_REMOTE': '1', 23:10:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:10:06 INFO - 'NO_EM_RESTART': '1', 23:10:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:10:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:10:06 INFO - 'PWD': '/builds/slave/test', 23:10:06 INFO - 'SHELL': '/bin/bash', 23:10:06 INFO - 'SHLVL': '1', 23:10:06 INFO - 'TERM': 'linux', 23:10:06 INFO - 'TMOUT': '86400', 23:10:06 INFO - 'USER': 'cltbld', 23:10:06 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464759983.559522-856082644', 23:10:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:06 INFO - '_': '/tools/buildbot/bin/python'} 23:10:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:10:06 INFO - Downloading/unpacking flake8 23:10:06 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 23:10:06 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 23:10:06 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 23:10:06 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 23:10:06 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 23:10:06 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 23:10:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:10:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:10:08 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 23:10:08 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 23:10:08 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 23:10:08 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 23:10:08 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 23:10:08 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 23:10:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:10:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:10:08 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 23:10:08 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 23:10:08 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 23:10:08 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 23:10:08 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 23:10:08 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 23:10:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:10:08 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 23:10:08 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 23:10:08 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 23:10:08 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 23:10:08 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 23:10:08 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 23:10:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:10:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:10:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:10:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:10:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:10:08 INFO - no previously-included directories found matching 'docs/_build' 23:10:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:10:09 INFO - Running setup.py install for pep8 23:10:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:10:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:10:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:10:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:10:09 INFO - no previously-included directories found matching 'docs/_build' 23:10:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:10:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:10:09 INFO - Cleaning up... 23:10:09 INFO - Return code: 0 23:10:09 INFO - Running post-action listener: _resource_record_post_action 23:10:09 INFO - Running post-action listener: _start_resource_monitoring 23:10:09 INFO - Starting resource monitoring. 23:10:09 INFO - ##### 23:10:09 INFO - ##### Finished create-virtualenv step (success) 23:10:09 INFO - ##### 23:10:09 INFO - ##### 23:10:09 INFO - ##### Running install step. 23:10:09 INFO - ##### 23:10:09 INFO - Running pre-action listener: _resource_record_pre_action 23:10:09 INFO - Running main action method: install 23:10:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:10:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:10:09 INFO - Reading from file tmpfile_stdout 23:10:09 INFO - Detecting whether we're running mozinstall >=1.0... 23:10:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:10:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:10:09 INFO - Reading from file tmpfile_stdout 23:10:09 INFO - Output received: 23:10:09 INFO - Usage: mozinstall [options] installer 23:10:09 INFO - Options: 23:10:09 INFO - -h, --help show this help message and exit 23:10:09 INFO - -d DEST, --destination=DEST 23:10:09 INFO - Directory to install application into. [default: 23:10:09 INFO - "/builds/slave/test"] 23:10:09 INFO - --app=APP Application being installed. [default: firefox] 23:10:09 INFO - mkdir: /builds/slave/test/build/application 23:10:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 23:10:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 23:10:26 INFO - Reading from file tmpfile_stdout 23:10:26 INFO - Output received: 23:10:26 INFO - /builds/slave/test/build/application/firefox/firefox 23:10:26 INFO - Running post-action listener: _resource_record_post_action 23:10:26 INFO - ##### 23:10:26 INFO - ##### Finished install step (success) 23:10:26 INFO - ##### 23:10:26 INFO - ##### 23:10:26 INFO - ##### Running run-tests step. 23:10:26 INFO - ##### 23:10:26 INFO - Running pre-action listener: _resource_record_pre_action 23:10:26 INFO - Running main action method: run_tests 23:10:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:10:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:10:26 INFO - Python 2.7.3 23:10:26 INFO - Return code: 0 23:10:26 INFO - grabbing minidump binary from tooltool 23:10:26 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')]} 23:10:26 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22769c0>, '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 0x22778c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2277d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:10:26 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 23:10:26 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 23:10:26 INFO - Calling ['/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'] with output_timeout 600 23:10:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:10:26 INFO - Return code: 0 23:10:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:10:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:10:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:10:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:10:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:10:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:10:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:10:27 INFO - Return code: 0 23:10:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RYuzWjGEQ76cjRlV_AQgEQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 23:10:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RYuzWjGEQ76cjRlV_AQgEQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --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 23:10:27 INFO - Using env: {'DISPLAY': ':0', 23:10:27 INFO - 'HOME': '/home/cltbld', 23:10:27 INFO - 'LANG': 'en_US.UTF-8', 23:10:27 INFO - 'LANGUAGE': 'en_US:en', 23:10:27 INFO - 'LOGNAME': 'cltbld', 23:10:27 INFO - 'MAIL': '/var/mail/cltbld', 23:10:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:10:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:10:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:27 INFO - 'MOZ_NO_REMOTE': '1', 23:10:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:10:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:10:27 INFO - 'NO_EM_RESTART': '1', 23:10:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:10:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:10:27 INFO - 'PWD': '/builds/slave/test', 23:10:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:10:27 INFO - 'SHELL': '/bin/bash', 23:10:27 INFO - 'SHLVL': '1', 23:10:27 INFO - 'TERM': 'linux', 23:10:27 INFO - 'TMOUT': '86400', 23:10:27 INFO - 'USER': 'cltbld', 23:10:27 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1464759983.559522-856082644', 23:10:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:27 INFO - '_': '/tools/buildbot/bin/python'} 23:10:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RYuzWjGEQ76cjRlV_AQgEQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 23:10:27 INFO - mozversion application_buildid: 20160531203041 23:10:27 INFO - mozversion application_changeset: 933c4c92752c3a9f51421d75ec9946642cc49dc2 23:10:27 INFO - mozversion application_display_name: Nightly 23:10:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:10:27 INFO - mozversion application_name: Firefox 23:10:27 INFO - mozversion application_remotingname: firefox 23:10:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:10:27 INFO - mozversion application_vendor: Mozilla 23:10:27 INFO - mozversion application_version: 49.0a1 23:10:27 INFO - mozversion platform_buildid: 20160531203041 23:10:27 INFO - mozversion platform_changeset: 933c4c92752c3a9f51421d75ec9946642cc49dc2 23:10:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:10:27 INFO - mozversion platform_version: 49.0a1 23:10:27 INFO - using testdate: 1464761427 23:10:27 INFO - actual date: 1464761427 23:10:27 INFO - starting webserver on 'localhost:36969' 23:10:27 INFO - SUITE-START | Running 2 tests 23:10:27 INFO - TEST-START | dromaeo_css 23:10:27 INFO - operating with platform_type : linux_ 23:10:27 INFO - Initialising browser for dromaeo_css test... 23:10:27 INFO - TEST-INFO | started process 19663 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7BWxj4/profile http://localhost:36969/getInfo.html) 23:10:30 INFO - PROCESS | 19663 | __metrics Screen width/height:1600/1200 23:10:30 INFO - PROCESS | 19663 | colorDepth:24 23:10:30 INFO - PROCESS | 19663 | Browser inner width/height: 1024/697 23:10:30 INFO - PROCESS | 19663 | __metrics 23:10:31 ERROR - PROCESS | 19663 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:10:32 INFO - TEST-INFO | 19663: exit 0 23:10:32 INFO - Browser initialized. 23:10:32 INFO - Running cycle 1/1 for dromaeo_css test... 23:10:32 INFO - TEST-INFO | started process 19749 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7BWxj4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:10:44 INFO - PROCESS | 19749 | RSS: Main: 156041216 23:10:44 INFO - PROCESS | 19749 | 23:11:35 INFO - PROCESS | 19749 | 1464761495434 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] 23:13:43 INFO - PROCESS | 19749 | Cycle 1(1): loaded http://localhost:36969/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36969/tests/dromaeo/cssquery-ext.html) 23:13:44 INFO - PROCESS | 19749 | RSS: Main: 254390272 23:13:44 INFO - PROCESS | 19749 | 23:16:46 INFO - PROCESS | 19749 | Cycle 1(1): loaded http://localhost:36969/tests/dromaeo/cssquery-ext.html (next: http://localhost:36969/tests/dromaeo/cssquery-jquery.html) 23:16:47 INFO - PROCESS | 19749 | RSS: Main: 239403008 23:16:47 INFO - PROCESS | 19749 | 23:19:49 INFO - PROCESS | 19749 | Cycle 1(1): loaded http://localhost:36969/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36969/tests/dromaeo/cssquery-mootools.html) 23:19:49 INFO - PROCESS | 19749 | RSS: Main: 239804416 23:19:49 INFO - PROCESS | 19749 | 23:22:51 INFO - PROCESS | 19749 | Cycle 1(1): loaded http://localhost:36969/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36969/tests/dromaeo/cssquery-prototype.html) 23:22:52 INFO - PROCESS | 19749 | RSS: Main: 231575552 23:22:52 INFO - PROCESS | 19749 | 23:25:54 INFO - PROCESS | 19749 | Cycle 1(1): loaded http://localhost:36969/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36969/tests/dromaeo/cssquery-yui.html) 23:25:55 INFO - PROCESS | 19749 | RSS: Main: 210616320 23:25:55 INFO - PROCESS | 19749 | 23:28:58 INFO - PROCESS | 19749 | Cycle 1(1): loaded http://localhost:36969/tests/dromaeo/cssquery-yui.html (next: http://localhost:36969/tests/dromaeo/cssquery-dojo.html) 23:28:58 INFO - PROCESS | 19749 | RSS: Main: 309587968 23:28:58 INFO - PROCESS | 19749 | 23:28:58 INFO - PROCESS | 19749 | __start_tp_report 23:28:58 INFO - PROCESS | 19749 | _x_x_mozilla_page_load 23:28:58 INFO - PROCESS | 19749 | _x_x_mozilla_page_load_details 23:28:58 INFO - PROCESS | 19749 | |i|pagename|runs| 23:28:58 INFO - PROCESS | 19749 | |0;dojo.html;3095.4737694591918;3102.1314032071;3128.671489493604;3129.499280115182;3163.2250098725817;5279.392869819972;5295.549878260343;5336.252924590555;5367.543758780498;5407.2700185475;5317.9468205317935;5337.306150200478;5372.059889519328;5388.649737767042;5389.6496727712765;4831.951680483203;4847.903041939177;4902.362692849924;4903.509649035103;5075.492450754932;4984.202527595586;5004.924926126111;5050.595952323805;5051.0403023425615;5062.987402519492;4773.57037866592;4808.495108013643;4813.085513752376;4830.106430310386;4871.780769865364;4797.64017698674;4799.376081109468;4882.121218180726;4884.218525035977;4920.75396230187;4746.738929358884;4813.109574728686;4834.7824347904425;4842.878928026792;4876.634252431082;5246.291750613695;5320.5211530962015;5333.35999680037;5420.105682562412;5428.511433970922;5797.246357973479;5800.332961709415;5828.242328497311;5831.387704291031;5835.649861008311;5631.5776316776;5642.294713160855;5838.241028666289;5850.853728656775;5853.5902486825935;5273.762680679379;5392.514673679309;5393.352797664266;5393.703346315951;5394.298741163623;5898.144769008555;5900.7049647518315;5901.02633065548;5906.055031194988;5907.645541267538;5488.1493368527945;5544.390117087117;5574.108142697149;5666.376698563155;5668.206451096849;5711.428857114339;5718.828435146952;5724.8282551523525;5728.971355143198;5732.570057245724;5678.659280443187;5717.113847353667;5721.5136713379825;5721.742521586539;5726.055200891889;5615.0454422748235;5664;5670.829875103754;5692.203091567184;5706.600537962386;4391.604755572014;4395.318725597537;4396.890077748082;4397.494288156903;4432.623227025739;3915.4126880967515;3926.469926559935;3942.8817135485983;3971.4042893566198;3988.441618173458;5290.259363689087;5293.12663410533;5358.97320513395;5405.027095122837;5409.945900540944;5752.856178595569;5755.625884317506;5756.453136951983;5768.048272035067;5790.826275211751;5416.783328666888;5423.566114710814;5423.620346575781;5427.48438898304;5432.212329212242;4833.540813622701;4931.802727890916;4962.528559786814;4970.776315065831;4971.676841005323;6012.368701286389;6015.969920150459;6017.157597936292;6018.398160183947;6020.69896505173;5783.4794868461195;5792.768289268382;5793.565482588739;5797.246357973437;5821.126830975388;5800.9419905800405;5945.524358051432;5974.342822289632;6011.549133814894;6065.696715164312;5717.256756621613;5757.107648314518;5759;5766.250387449605;5773.942260577509;5652;5760.049591817471;5795.768169273182;5799.9130013049;5812;5642;5700.857478562903;5704.458076482728;5735.053716136791;5740.885182296414;5687.886242275049;5698.943010569841;5705.37240903492;5708;5709.885802284014;5357.651752636066;5474.288342515448;5596.3284405871555;5608.691521966331;5615.185798059177;5630.5214056805635;5742.856428589319;5749.051406518045;5752.9712351437975;5755.5683323750045;5505.174223866452;5510.889782204414;5529.529989950899;5541.861453463695;5554.50009499147 23:28:58 INFO - PROCESS | 19749 | |1;ext.html;549.7991118629731;580.4949693766423;592.437184674559;603.3739073197728;608.2305883057933;32685.50971735426;35629.10927226821;42922;44196;44246.557534424646;45481;45937.99999999992;45942.54057459424;46059.769701151534;46075;8789.340799440051;8958.32812539059;8985.775355616097;8991.95504022479;8994.550272486349;8722.30221582272;8808.603612837438;8832.911670883273;8838.779030524256;8841.60212790426;8847.690330838423;8897;8919;8919.063498332678;8919.063498332678;8841.646334146659;8885.644574217089;8887;8887.866681999774;8889.199972002518;8643.438176518506;8681.088485709037;8737.912620873774;8747.256483198937;8752.431091979;42447.57552424498;42710.35934460985;42752.78623606893;42888.57111428877;42893.14213715708;3404.8297585120645;3416.231347946717;3699.7995694454594;4108.465899433085;4179.540250572434;32232.355352893046;32506.18734531632;33101;33542;33729;4427.092446048552;4429.468463784334;4472.284434490499;4510;4574.382458368111;317004;321548;325291;325341;325971;53447.732761335945;59035.40964590299;59346.406535934955;59603;59676;62356.376436235965;63597;64215.35784642187;68253;68636;16077.758833617505;16185;16203.270852811651;16243.918780406022;16264.268107935171;10906.781864362669;10935.125189984783;10941.45292735376;10945.23383363157;10975.176861735401;18105;18180.818191818176;18221.817781822276;18301.816981830278;18336;6239.563230573816;6409.436864499935;6428.582142160744;6450.387213214737;6490.545661803629;906.5150144672568;988.8417853143607;1082.7996820588216;1100.3178029621686;1134.2098437842833;31989.52015719766;32676.509852352232;33391;34512.270107328826;35002.199824014526;840.2143995364354;1096.1231015187818;1130.3444002478543;1171.800793865045;1193.665773583398;16412.261448234858;16458;16478.2584783685;16525.83474165243;16532.504024879272;494552;499818;500575;500914;504152;57700.42299577034;58035.12947305794;58054;58108.709456452445;58201.12698309529;1224.9142560020891;1342.9664258393618;1369.1442848219863;1369.301656155348;1378.7587172244816;31758.364832702755;32793.34413311768;32885.342293154485;33016.33967320592;33231.33537329191;44685.776571116934;44738;44922.550774491836;45135.54864451313;45149.77425112853;378461;379002;380716;381686;425175;26995.325116872235;27790.637795787585;28152.85923570451;29069.27326816762;29320;47336.7633161832;48037.75981120072;48422.273665895744;49013.50986490232;49722.75138624284;40135.79932100321;41233;41390.37914431225;41570.4548962202;42341.1531769369;39778;40087.1982560353;40609.390859137726;41012.38481422721;41274.38088428616;39500.604993949695;39639.603603964744;39936.80031599823;40518.59481405266;40827.59172408238;34981.82509087438;36201.27597447984;36858;36988.44517332296;37309.81345093257;27454.5881811769;27476;27696;28030.2992425191;28072.719272807826 23:28:58 INFO - PROCESS | 19749 | |2;jquery.html;395.6301752502509;399.56447472255235;399.96400323970846;401.221630037727;418.22419411990757;18259.543511412223;19558.119884605192;19642.705359419604;19654;20602.278920237793;18312.175952082154;18898.622027559475;19127.42617721467;19228.519287017833;19435.416937491864;5217.921731174045;5251.921221181686;5312;5344.198370244475;5349.8127565535215;5249.107651699221;5295.258663787073;5298.4436634153435;5299.629025968184;5317.229001794737;5224.947750522484;5232.502912223333;5285.154375299952;5297.655652382583;5299.973500132513;5262.7631756571045;5287.4448182941005;5300.708461034642;5307.734613269321;5336.786528538853;5039.924401133986;5160.638755287131;5344.9732751336;5350.812721554766;5427.240186373911;13597;13908.095973761774;13990.790138147935;14000.159990400609;14059.578212653534;2112.2607087519245;2133.4453042208984;2225.955480890373;2234.2515257388795;2297.9888848906426;9862.802743945153;9957.302988790787;10045.799084018352;10324.58701651933;10482.633107841266;1818.5635447492639;1823.4894229615595;1916.7124931260282;1940.078462730206;1955.628430598196;83783.58108209481;85664.14335856625;86619.56690216508;86778;88081.55959220228;10975.341479511255;10975.890241097646;11051.778964420666;11088.33469991803;11190.32858028521;15846.841531584767;15984.520464386087;16060.919695401448;16066.27701753424;16070.919645401931;7350.2649735027135;7607.429442791813;7689.461737678421;7815.92184078152;7839.529628222325;6770.221424536241;6910;6921.48088893335;6927;7266.890996635055;4728.101660684459;4753.001869607352;4804.8318308859725;4891.559759621651;4939.506049395103;1945;1979.5249140206247;1981.9009049547465;2020.6867935470025;2051.415346626204;903.3676426501476;961.9759506012266;982.4891056650501;1075.172117469544;1094.4637127807316;19423.91585824976;19772.60454790925;19944.70082948757;19999.800002000084;20084.89957550203;971.1114330387617;1000.4247557654378;1013.6350913671073;1033.8449232615017;1036.5698235232294;8860.778480537909;10919.181061420266;11004.339739615489;11096.667099987013;11127.833082503768;411318;507163;517506;518046;534384;97542;99124.50437747766;101925;102269;102585.48707256417;963.0658261486348;991.494337887668;1000.8698869146964;1021.2289721260549;1021.2493817044466;16458;17244.74132888033;17281.56796080108;18148.183331750366;18464.07679615987;32457.35085298328;34583.30833383369;42190.36714449347;43580.34629480497;44808.551914480435;59562;60329.39670603413;62383.37616623957;62515.6874215626;62910.685446572475;8730.781730456789;8841.027486976556;8940.374173808032;9052.773680658036;9122.543872806466;10051.899481005097;14010.789838152232;14108.576742697736;14351.85648143547;14367.066140700821;11963.641090766943;12100.515979360727;12111.091668125102;12244.693882653006;12359.25844449336;11723.41382930867;11787.587434439753;12053.51785928553;12115.394230288273;12306.200096993667;12262.528496580468;12397.690057748629;12567.748645027232;12583.307918064595;12702.237865728086;8735.912640873765;8738.650453981769;8941.508217048126;9040.452768632485;9239.72280831576;8983.236424903957;11314.60398886035;12090.395480226129;12357.443915024025;12497.37513124322 23:28:58 INFO - PROCESS | 19749 | |3;mootools.html;1309.6529419703775;1433.448122472848;1493.186213513635;1582.2326171806671;1798.2177752677587;8198.713045043425;8440.788980275496;8551.828963420729;8672;8749.168828961254;8462.449940753846;8710.346723995694;8726.607302671378;8731.257843083346;8756.824863502741;1998.2806189771743;2043.5402034542258;2052.148358431249;2363.3973336799136;2392.9710224603414;2347.248880358286;2404.927852164429;2409.8433601815827;2422.0675040109595;2430.295214387834;2336.766323367658;2345.3784747042046;2354;2356.1871154451687;2386.2364043506;2000.0599718132455;2201.5046614511766;2366.100881664965;2401.8198635102435;2405.0980882169188;2285.0745448093385;2327.8603283803027;2330.557194133109;2333.0900948630047;2333.988330058356;8376.748697539084;8446.450980686235;8464.44981076228;8466.449680770791;8469.237768600855;5133.332666753336;5221.582273418156;5231.712255825928;5264.052470555299;5265.763040663141;3183.6338821035647;3321.667833216683;3513.350030244413;3517.050396392985;3541.698955588778;1161.1523587780882;1169.7192673758236;1175.3183153770879;1222.4865556466304;1232.4577186038205;11771.7057073573;11791.528338866436;11869.228500147548;11869.703257418547;11875.762484750343;4634.629229661619;4650.442101895836;4755.690880092783;4785.377900872864;4793.01743142655;10087.596496140219;10093.192544596415;10100.797984040279;10114.54484548197;10115.645952391631;5119.078565858182;5171.146760784503;5172.405173405032;5174.663646862942;5178.870528236825;4211.515675697273;4657.813687452532;4804.615630749532;4824.842037910876;4877.219644856806;3897.8830635080994;3947.802609869495;3968.6428221460205;4013.979930100331;4032.91934161321;1221.4381384563023;1240.2682417373792;1241.3544956622507;1260.3446207971804;1276.2342594443446;994.8955359687128;995.2038369304528;996.7956568903357;1004.5178314409125;1006.5168719014914;5895.233619629421;5935.851603709942;5946.910796338058;6134.570580059442;6170.167027451326;414.21506245664295;448.6836780070043;449.8942748454111;450.3155204089765;450.5832105302582;4293.377460268243;4293.69944103916;4347.478302603708;4359.825606975685;4416.933745993812;10374.325668831501;10817.080548153337;10857.891421085846;10871.565137394573;10881.292715973437;10778.622748203776;10784.460776961121;10796.406197659204;10803.891961080288;10805;7644.847103057908;7990.68037278514;7996.760097196977;8074.354051675852;8145;5904.675242861684;6031.939680603138;6087.969560152171;6250.124982502544;6273.121762953099;9916.752081198028;9961.701148965543;10109.342892712244;10117.08946194846;10126.645567405105;9981.201503879527;10039.096481316716;10109.949450252701;10133.797324053625;10405.219608529542;7055.506114571931;7591.3547348475995;7762.223777622193;7806.336461400844;7964.084130324855;8442.53566053873;8458.154184581492;8471.4493557921;8502.82994340122;8512.233898949124;7480.251974802476;7681.923180768121;7771.611419429119;7880.802979925547;7918.604069796603;7618.504797188165;7627.084749830056;7644.197359277196;7809.492382995087;7812.140664526783;6608.471322294109;6643.236027856665;6673.699683514156;6682.3317668232785;6682.599044057372;5142.8971420572125;5176.352955880515;5225.216217567396;5379.946200537945;5396.9460305398015;5169.4830516948;5216.478352164753;5288.524032837063;5331.1470164773455;5335.546478549367 23:28:58 INFO - PROCESS | 19749 | |4;prototype.html;331.50135217656805;334.9949750753738;341.5593883889782;341.992831112374;345.3076581454185;5270.65740726853;5327.893442131155;5342.332208473941;5350.2777125088105;5358.91961620576;4940.431850337212;5150.17168905038;5159.226116082589;5164.561012313958;5261.710605916673;4018.97990510047;4098.200850834096;4168.478940132483;4178.937315940263;4206.1377417629465;4152.466995132966;4160;4174.749515029092;4186.5813418658045;4188.308929026707;4037.4347591337237;4083.3466645336753;4168.728537795971;4183.916321673565;4193.895152621194;3942.8225729842084;4032.657224135937;4138.441310423084;4149.854755083557;4151;3705.4441833724886;3706.5552133743854;3713.2573485303046;3716.2753263113705;3726.9813650931574;5062.911474033101;5105.846824595268;5114.718690472023;5126.897462050775;5133.743312834381;4631.374764406829;4712.58622413278;4738.336632871401;4743.525647435264;4753.881152971168;5460.5085542300985;5476.507114359727;5487.807926722586;5496.587755918322;5514.80698175566;4033.233685599727;4033.9596604033877;4049.574794646549;4058.3506638937924;4068.735532190428;5538.667679939216;5651;5690.374058853523;5692.402297758758;5741.650712082657;4141.855035073758;4151;4158.064435501988;4165.375193720966;4178.623923846869;4211.55778643238;4217.367394890791;4221.472315960505;4221.746695198298;4222.239996800606;4618.630509559227;4715.622750180046;4725.125851717443;4737.360456338419;4756;5470.56235501159;5540.279763630783;5540.556755459554;5543.279373681396;5558.388577256498;1427;1446.4503488674236;1457.7099267148649;1459.839417664056;1462.926853657313;910.1853840812436;955.285262953001;956.1681337236648;957.8850537935353;965.7537327981461;4730.107956817232;4769.308450274691;4778.378810754649;4805.471398146201;4827.227643577011;4981.252812078144;5010.473900240495;5015.3480047593575;5024.346834911511;5031;4765.761711914391;4770.833020844323;4832.44426890912;4992.251162325608;5096.668716533413;2988.2977500287416;3034.2111051126426;3050.2984313607994;3054.106453998535;3056.449839028952;5843.211166492469;5843.328017277982;5857.238558987389;5887.8233652990475;5887.882242355129;5638.182463542763;5750;5805.622634528742;5822.8354329134345;5828.213191219216;5827.912581311199;5893.499052580493;5897.852553686193;5900.911486327708;5946.8810623787285;5582.86042848932;5629.802956896653;5715.114157305624;5716.342620598518;5717.37108918027;5540.4763689985575;5585.301837270341;5635.351934527582;5638.520725738194;5656.830295090989;5824.94175058244;5873.765049397976;5883.941160588511;5888.735006924784;5896.941030589639;3828.5597156326266;4114.506259248909;4117.970507373157;4172.4993000840095;4177.58224177592;5700.942990570207;5715.542756579381;5719.7426115824055;5721.399253078367;5736.013470637867;5546;5556.972215138899;5588.854284871511;5591.217229587943;5594.356648985418;5420.593455490933;5448.863778405572;5554;5559.63862348946;5567.802922371709;5374.677519348852;5397.568194544348;5409.567234621142;5429.837104886859;5450.918236226539;5322.627416080837;5426.236473146164;5487.490939991534;5504.2018907257425;5623.465770751772;5466.426025267289;5479.726013699379;5493.478119578634;5493.890122197454;5524.944750552443 23:28:58 INFO - PROCESS | 19749 | |5;yui.html;730.9159446663633;765.169790777007;852.8550146475098;856.3406177243522;878.6573236437787;14399.424023039066;15072.095674259552;15262.93159478837;15279.541613751606;15292.617684557892;13750.793738093937;14509.637259068528;14516.854831451683;14519;14535.345909434074;826.9669213231464;833.2625626320689;833.8040560468285;839.1105428246078;839.9622017009249;696.5994553131944;814.4828034198267;824.2169938558363;838.0990435282066;841.9242268195861;867.7960679240374;871.6905498548019;871.8387098386787;872.6422166911567;873.6243415331405;865.3336930563494;866.6879923227633;869.5087275689216;869.5478351257342;869.7173418638936;528.8545649946257;614.7602435050334;630.5145038320513;630.8422894276431;632.7627139822566;14895.478658247017;14918.70162596753;14920.701585968329;14922.403103875831;14923.030003049875;13452.663683407894;13827.446902124004;13918.37367318463;13994.300284985811;14116.435342586386;11974.161808673396;12078.818817717653;12212.572559960448;12236.449359778831;12269.631911042683;4452.176347375714;4462.709923854972;4514.774261286955;4554.567316104998;4576.954230457686;57825;58074.70962645202;58093.41906580965;58127.709361453344;58484.99999999958;11103.83344249837;11191.160662950311;11192.216544841784;11225.775484490265;11257.71855703614;19663.803361966482;19701.704474432896;19714.802851971584;19734.70397944032;19750.604987900162;8077.27304542594;8507.27688146502;8527.317814574819;8612.224899758927;8707.695230666895;4640.65195110368;4794.472608013116;4813.831515896997;4893.412790465167;4897.608191344755;3405.1997780521556;3412.0616830371846;3476.8261586921058;3478.4434490481403;3480.89557313281;650.2814390098968;655.1090516897016;655.9606423614503;657.2080642825384;657.8585604095142;613.2058983616228;654.6203202142746;738.5015114797491;744.5309455043288;753.3031945450437;9104.590293436811;9658.32391732586;9737.513124343754;9755.219582433388;9762.316637835425;698.3121625199175;718.256604414439;722.8012296618367;741.4513260187423;752.5710345103348;4438.400815889878;4687.414073240845;4693.366395536627;4696.342512048316;4723.362346083235;65300;66539.66730166414;67045.66477167583;68191;68295.3170468289;58936.410635893095;60137.699311503166;60192;60978.39021609727;62110.37889621136;53053.46946530562;53096;53103.468965309854;54224.45775542273;55282;8830.735077947671;8862.335324850534;8969.37214394986;8971.685990990283;9118.452892826452;35871.64128358787;36621;36810.079748006516;37061;37168.25663486769;45700.771496142304;46448.30327545022;48120.27819582779;49388.50611493839;49514.25728614002;11318.717032073935;11350.148738844455;11465.656030319104;11856.347900865536;13275.933620331836;12448.81326780081;12676.683082923;12685.492580296685;12767.170133941265;12994.415251313525;11815.940920295343;12107.273563586214;12133.453994570089;12289.201201921847;12298.077644176901;11540.94229528847;11975.520979160736;12097.879021210027;12477.572256068639;12578.55975040869;11790;12498.812517812059;12624.621261362174;12628.11603187768;12637.052221083271;9938.936603286558;10344.586216551254;10356.53395597215;10398.376097434179;10448.268621196443;9703.805923881624;9969.900300997188;10078.496075196357;10709;10747.46262686847 23:28:58 INFO - PROCESS | 19749 | __end_tp_report 23:28:58 INFO - PROCESS | 19749 | __start_cc_report 23:28:58 INFO - PROCESS | 19749 | _x_x_mozilla_cycle_collect,808 23:28:58 INFO - PROCESS | 19749 | __end_cc_report 23:28:58 INFO - PROCESS | 19749 | __startTimestamp1464762538544__endTimestamp 23:28:58 INFO - PROCESS | 19749 | 23:28:58 INFO - PROCESS | 19749 | ------- Summary: start ------- 23:28:58 INFO - PROCESS | 19749 | Number of tests: 6 23:28:58 INFO - PROCESS | 19749 | 23:28:58 INFO - PROCESS | 19749 | [#0] dojo.html Cycles:165 Average:5347.69 Median:5544.39 stddev:611.65 (11.0%) stddev-sans-first:587.46 23:28:58 INFO - PROCESS | 19749 | Values: 3095.5 3102.1 3128.7 3129.5 3163.2 5279.4 5295.5 5336.3 5367.5 5407.3 5317.9 5337.3 5372.1 5388.6 5389.6 4832.0 4847.9 4902.4 4903.5 5075.5 4984.2 5004.9 5050.6 5051.0 5063.0 4773.6 4808.5 4813.1 4830.1 4871.8 4797.6 4799.4 4882.1 4884.2 4920.8 4746.7 4813.1 4834.8 4842.9 4876.6 5246.3 5320.5 5333.4 5420.1 5428.5 5797.2 5800.3 5828.2 5831.4 5835.6 5631.6 5642.3 5838.2 5850.9 5853.6 5273.8 5392.5 5393.4 5393.7 5394.3 5898.1 5900.7 5901.0 5906.1 5907.6 5488.1 5544.4 5574.1 5666.4 5668.2 5711.4 5718.8 5724.8 5729.0 5732.6 5678.7 5717.1 5721.5 5721.7 5726.1 5615.0 5664.0 5670.8 5692.2 5706.6 4391.6 4395.3 4396.9 4397.5 4432.6 3915.4 3926.5 3942.9 3971.4 3988.4 5290.3 5293.1 5359.0 5405.0 5409.9 5752.9 5755.6 5756.5 5768.0 5790.8 5416.8 5423.6 5423.6 5427.5 5432.2 4833.5 4931.8 4962.5 4970.8 4971.7 6012.4 6016.0 6017.2 6018.4 6020.7 5783.5 5792.8 5793.6 5797.2 5821.1 5800.9 5945.5 5974.3 6011.5 6065.7 5717.3 5757.1 5759.0 5766.3 5773.9 5652.0 5760.0 5795.8 5799.9 5812.0 5642.0 5700.9 5704.5 5735.1 5740.9 5687.9 5698.9 5705.4 5708.0 5709.9 5357.7 5474.3 5596.3 5608.7 5615.2 5630.5 5742.9 5749.1 5753.0 5755.6 5505.2 5510.9 5529.5 5541.9 5554.5 23:28:58 INFO - PROCESS | 19749 | 23:28:58 INFO - PROCESS | 19749 | [#1] ext.html Cycles:180 Average:57061.54 Median:22875.00 stddev:108621.04 (474.8%) stddev-sans-first:108842.88 23:28:58 INFO - PROCESS | 19749 | Values: 549.8 580.5 592.4 603.4 608.2 32685.5 35629.1 42922.0 44196.0 44246.6 45481.0 45938.0 45942.5 46059.8 46075.0 8789.3 8958.3 8985.8 8992.0 8994.6 8722.3 8808.6 8832.9 8838.8 8841.6 8847.7 8897.0 8919.0 8919.1 8919.1 8841.6 8885.6 8887.0 8887.9 8889.2 8643.4 8681.1 8737.9 8747.3 8752.4 42447.6 42710.4 42752.8 42888.6 42893.1 3404.8 3416.2 3699.8 4108.5 4179.5 32232.4 32506.2 33101.0 33542.0 33729.0 4427.1 4429.5 4472.3 4510.0 4574.4 317004.0 321548.0 325291.0 325341.0 325971.0 53447.7 59035.4 59346.4 59603.0 59676.0 62356.4 63597.0 64215.4 68253.0 68636.0 16077.8 16185.0 16203.3 16243.9 16264.3 10906.8 10935.1 10941.5 10945.2 10975.2 18105.0 18180.8 18221.8 18301.8 18336.0 6239.6 6409.4 6428.6 6450.4 6490.5 906.5 988.8 1082.8 1100.3 1134.2 31989.5 32676.5 33391.0 34512.3 35002.2 840.2 1096.1 1130.3 1171.8 1193.7 16412.3 16458.0 16478.3 16525.8 16532.5 494552.0 499818.0 500575.0 500914.0 504152.0 57700.4 58035.1 58054.0 58108.7 58201.1 1224.9 1343.0 1369.1 1369.3 1378.8 31758.4 32793.3 32885.3 33016.3 33231.3 44685.8 44738.0 44922.6 45135.5 45149.8 378461.0 379002.0 380716.0 381686.0 425175.0 26995.3 27790.6 28152.9 29069.3 29320.0 47336.8 48037.8 48422.3 49013.5 49722.8 40135.8 41233.0 41390.4 41570.5 42341.2 39778.0 40087.2 40609.4 41012.4 41274.4 39500.6 39639.6 39936.8 40518.6 40827.6 34981.8 36201.3 36858.0 36988.4 37309.8 27454.6 27476.0 27696.0 28030.3 28072.7 23:28:58 INFO - PROCESS | 19749 | 23:28:58 INFO - PROCESS | 19749 | [#2] jquery.html Cycles:180 Average:29387.94 Median:2230.10 stddev:82713.68 (3709.0%) stddev-sans-first:82917.07 23:28:58 INFO - PROCESS | 19749 | Values: 395.6 399.6 400.0 401.2 418.2 18259.5 19558.1 19642.7 19654.0 20602.3 18312.2 18898.6 19127.4 19228.5 19435.4 5217.9 5251.9 5312.0 5344.2 5349.8 5249.1 5295.3 5298.4 5299.6 5317.2 5224.9 5232.5 5285.2 5297.7 5300.0 5262.8 5287.4 5300.7 5307.7 5336.8 5039.9 5160.6 5345.0 5350.8 5427.2 13597.0 13908.1 13990.8 14000.2 14059.6 2112.3 2133.4 2226.0 2234.3 2298.0 9862.8 9957.3 10045.8 10324.6 10482.6 1818.6 1823.5 1916.7 1940.1 1955.6 83783.6 85664.1 86619.6 86778.0 88081.6 10975.3 10975.9 11051.8 11088.3 11190.3 15846.8 15984.5 16060.9 16066.3 16070.9 7350.3 7607.4 7689.5 7815.9 7839.5 6770.2 6910.0 6921.5 6927.0 7266.9 4728.1 4753.0 4804.8 4891.6 4939.5 1945.0 1979.5 1981.9 2020.7 2051.4 903.4 962.0 982.5 1075.2 1094.5 19423.9 19772.6 19944.7 19999.8 20084.9 971.1 1000.4 1013.6 1033.8 1036.6 8860.8 10919.2 11004.3 11096.7 11127.8 411318.0 507163.0 517506.0 518046.0 534384.0 97542.0 99124.5 101925.0 102269.0 102585.5 963.1 991.5 1000.9 1021.2 1021.2 16458.0 17244.7 17281.6 18148.2 18464.1 32457.4 34583.3 42190.4 43580.3 44808.6 59562.0 60329.4 62383.4 62515.7 62910.7 8730.8 8841.0 8940.4 9052.8 9122.5 10051.9 14010.8 14108.6 14351.9 14367.1 11963.6 12100.5 12111.1 12244.7 12359.3 11723.4 11787.6 12053.5 12115.4 12306.2 12262.5 12397.7 12567.7 12583.3 12702.2 8735.9 8738.7 8941.5 9040.5 9239.7 8983.2 11314.6 12090.4 12357.4 12497.4 23:28:58 INFO - PROCESS | 19749 | 23:28:58 INFO - PROCESS | 19749 | [#3] mootools.html Cycles:180 Average:5739.26 Median:4642.54 stddev:3240.19 (69.8%) stddev-sans-first:3232.18 23:28:58 INFO - PROCESS | 19749 | Values: 1309.7 1433.4 1493.2 1582.2 1798.2 8198.7 8440.8 8551.8 8672.0 8749.2 8462.4 8710.3 8726.6 8731.3 8756.8 1998.3 2043.5 2052.1 2363.4 2393.0 2347.2 2404.9 2409.8 2422.1 2430.3 2336.8 2345.4 2354.0 2356.2 2386.2 2000.1 2201.5 2366.1 2401.8 2405.1 2285.1 2327.9 2330.6 2333.1 2334.0 8376.7 8446.5 8464.4 8466.4 8469.2 5133.3 5221.6 5231.7 5264.1 5265.8 3183.6 3321.7 3513.4 3517.1 3541.7 1161.2 1169.7 1175.3 1222.5 1232.5 11771.7 11791.5 11869.2 11869.7 11875.8 4634.6 4650.4 4755.7 4785.4 4793.0 10087.6 10093.2 10100.8 10114.5 10115.6 5119.1 5171.1 5172.4 5174.7 5178.9 4211.5 4657.8 4804.6 4824.8 4877.2 3897.9 3947.8 3968.6 4014.0 4032.9 1221.4 1240.3 1241.4 1260.3 1276.2 994.9 995.2 996.8 1004.5 1006.5 5895.2 5935.9 5946.9 6134.6 6170.2 414.2 448.7 449.9 450.3 450.6 4293.4 4293.7 4347.5 4359.8 4416.9 10374.3 10817.1 10857.9 10871.6 10881.3 10778.6 10784.5 10796.4 10803.9 10805.0 7644.8 7990.7 7996.8 8074.4 8145.0 5904.7 6031.9 6088.0 6250.1 6273.1 9916.8 9961.7 10109.3 10117.1 10126.6 9981.2 10039.1 10109.9 10133.8 10405.2 7055.5 7591.4 7762.2 7806.3 7964.1 8442.5 8458.2 8471.4 8502.8 8512.2 7480.3 7681.9 7771.6 7880.8 7918.6 7618.5 7627.1 7644.2 7809.5 7812.1 6608.5 6643.2 6673.7 6682.3 6682.6 5142.9 5176.4 5225.2 5379.9 5396.9 5169.5 5216.5 5288.5 5331.1 5335.5 23:28:58 INFO - PROCESS | 19749 | 23:28:58 INFO - PROCESS | 19749 | [#4] prototype.html Cycles:180 Average:4632.04 Median:5141.96 stddev:1340.70 (26.1%) stddev-sans-first:1305.03 23:28:58 INFO - PROCESS | 19749 | Values: 331.5 335.0 341.6 342.0 345.3 5270.7 5327.9 5342.3 5350.3 5358.9 4940.4 5150.2 5159.2 5164.6 5261.7 4019.0 4098.2 4168.5 4178.9 4206.1 4152.5 4160.0 4174.7 4186.6 4188.3 4037.4 4083.3 4168.7 4183.9 4193.9 3942.8 4032.7 4138.4 4149.9 4151.0 3705.4 3706.6 3713.3 3716.3 3727.0 5062.9 5105.8 5114.7 5126.9 5133.7 4631.4 4712.6 4738.3 4743.5 4753.9 5460.5 5476.5 5487.8 5496.6 5514.8 4033.2 4034.0 4049.6 4058.4 4068.7 5538.7 5651.0 5690.4 5692.4 5741.7 4141.9 4151.0 4158.1 4165.4 4178.6 4211.6 4217.4 4221.5 4221.7 4222.2 4618.6 4715.6 4725.1 4737.4 4756.0 5470.6 5540.3 5540.6 5543.3 5558.4 1427.0 1446.5 1457.7 1459.8 1462.9 910.2 955.3 956.2 957.9 965.8 4730.1 4769.3 4778.4 4805.5 4827.2 4981.3 5010.5 5015.3 5024.3 5031.0 4765.8 4770.8 4832.4 4992.3 5096.7 2988.3 3034.2 3050.3 3054.1 3056.4 5843.2 5843.3 5857.2 5887.8 5887.9 5638.2 5750.0 5805.6 5822.8 5828.2 5827.9 5893.5 5897.9 5900.9 5946.9 5582.9 5629.8 5715.1 5716.3 5717.4 5540.5 5585.3 5635.4 5638.5 5656.8 5824.9 5873.8 5883.9 5888.7 5896.9 3828.6 4114.5 4118.0 4172.5 4177.6 5700.9 5715.5 5719.7 5721.4 5736.0 5546.0 5557.0 5588.9 5591.2 5594.4 5420.6 5448.9 5554.0 5559.6 5567.8 5374.7 5397.6 5409.6 5429.8 5450.9 5322.6 5426.2 5487.5 5504.2 5623.5 5466.4 5479.7 5493.5 5493.9 5524.9 23:28:58 INFO - PROCESS | 19749 | 23:28:58 INFO - PROCESS | 19749 | [#5] yui.html Cycles:180 Average:15510.43 Median:26457.38 stddev:18462.85 (69.8%) stddev-sans-first:18481.28 23:28:58 INFO - PROCESS | 19749 | Values: 730.9 765.2 852.9 856.3 878.7 14399.4 15072.1 15262.9 15279.5 15292.6 13750.8 14509.6 14516.9 14519.0 14535.3 827.0 833.3 833.8 839.1 840.0 696.6 814.5 824.2 838.1 841.9 867.8 871.7 871.8 872.6 873.6 865.3 866.7 869.5 869.5 869.7 528.9 614.8 630.5 630.8 632.8 14895.5 14918.7 14920.7 14922.4 14923.0 13452.7 13827.4 13918.4 13994.3 14116.4 11974.2 12078.8 12212.6 12236.4 12269.6 4452.2 4462.7 4514.8 4554.6 4577.0 57825.0 58074.7 58093.4 58127.7 58485.0 11103.8 11191.2 11192.2 11225.8 11257.7 19663.8 19701.7 19714.8 19734.7 19750.6 8077.3 8507.3 8527.3 8612.2 8707.7 4640.7 4794.5 4813.8 4893.4 4897.6 3405.2 3412.1 3476.8 3478.4 3480.9 650.3 655.1 656.0 657.2 657.9 613.2 654.6 738.5 744.5 753.3 9104.6 9658.3 9737.5 9755.2 9762.3 698.3 718.3 722.8 741.5 752.6 4438.4 4687.4 4693.4 4696.3 4723.4 65300.0 66539.7 67045.7 68191.0 68295.3 58936.4 60137.7 60192.0 60978.4 62110.4 53053.5 53096.0 53103.5 54224.5 55282.0 8830.7 8862.3 8969.4 8971.7 9118.5 35871.6 36621.0 36810.1 37061.0 37168.3 45700.8 46448.3 48120.3 49388.5 49514.3 11318.7 11350.1 11465.7 11856.3 13275.9 12448.8 12676.7 12685.5 12767.2 12994.4 11815.9 12107.3 12133.5 12289.2 12298.1 11540.9 11975.5 12097.9 12477.6 12578.6 11790.0 12498.8 12624.6 12628.1 12637.1 9938.9 10344.6 10356.5 10398.4 10448.3 9703.8 9969.9 10078.5 10709.0 10747.5 23:28:58 INFO - PROCESS | 19749 | -------- Summary: end -------- 23:28:58 INFO - PROCESS | 19749 | 23:28:59 INFO - TEST-INFO | 19749: exit 0 23:28:59 INFO - TEST-OK | dromaeo_css | took 1111887ms 23:28:59 INFO - TEST-START | kraken 23:28:59 INFO - operating with platform_type : linux_ 23:28:59 INFO - Initialising browser for kraken test... 23:28:59 INFO - TEST-INFO | started process 19933 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRNNlU8/profile http://localhost:36969/getInfo.html) 23:29:02 INFO - PROCESS | 19933 | __metrics Screen width/height:1600/1200 23:29:02 INFO - PROCESS | 19933 | colorDepth:24 23:29:02 INFO - PROCESS | 19933 | Browser inner width/height: 1024/697 23:29:02 INFO - PROCESS | 19933 | __metrics 23:29:03 ERROR - PROCESS | 19933 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:29:04 INFO - TEST-INFO | 19933: exit 0 23:29:04 INFO - Browser initialized. 23:29:04 INFO - Running cycle 1/1 for kraken test... 23:29:04 INFO - TEST-INFO | started process 20017 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRNNlU8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:29:16 INFO - PROCESS | 20017 | RSS: Main: 155594752 23:29:16 INFO - PROCESS | 20017 | 23:29:18 INFO - PROCESS | 20017 | Cycle 1(1): loaded http://localhost:36969/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36969/tests/kraken/driver.html?testName=audio-beat-detection) 23:29:19 INFO - PROCESS | 20017 | RSS: Main: 214298624 23:29:19 INFO - PROCESS | 20017 | 23:29:22 INFO - PROCESS | 20017 | Cycle 1(1): loaded http://localhost:36969/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36969/tests/kraken/driver.html?testName=audio-dft) 23:29:22 INFO - PROCESS | 20017 | RSS: Main: 199307264 23:29:22 INFO - PROCESS | 20017 | 23:29:25 INFO - PROCESS | 20017 | Cycle 1(1): loaded http://localhost:36969/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36969/tests/kraken/driver.html?testName=audio-fft) 23:29:26 INFO - PROCESS | 20017 | RSS: Main: 268496896 23:29:26 INFO - PROCESS | 20017 | 23:29:28 INFO - PROCESS | 20017 | Cycle 1(1): loaded http://localhost:36969/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36969/tests/kraken/driver.html?testName=audio-oscillator) 23:29:29 INFO - PROCESS | 20017 | RSS: Main: 178786304 23:29:29 INFO - PROCESS | 20017 | 23:29:31 INFO - PROCESS | 20017 | Cycle 1(1): loaded http://localhost:36969/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36969/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:29:31 INFO - PROCESS | 20017 | RSS: Main: 182980608 23:29:31 INFO - PROCESS | 20017 | 23:29:34 INFO - PROCESS | 20017 | Cycle 1(1): loaded http://localhost:36969/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36969/tests/kraken/driver.html?testName=imaging-darkroom) 23:29:35 INFO - PROCESS | 20017 | RSS: Main: 217968640 23:29:35 INFO - PROCESS | 20017 | 23:29:38 INFO - PROCESS | 20017 | Cycle 1(1): loaded http://localhost:36969/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36969/tests/kraken/driver.html?testName=imaging-desaturate) 23:29:39 INFO - PROCESS | 20017 | RSS: Main: 220057600 23:29:39 INFO - PROCESS | 20017 | 23:29:42 INFO - PROCESS | 20017 | Cycle 1(1): loaded http://localhost:36969/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36969/tests/kraken/driver.html?testName=json-parse-financial) 23:29:43 INFO - PROCESS | 20017 | RSS: Main: 220680192 23:29:43 INFO - PROCESS | 20017 | 23:29:44 INFO - PROCESS | 20017 | Cycle 1(1): loaded http://localhost:36969/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36969/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:29:45 INFO - PROCESS | 20017 | RSS: Main: 209039360 23:29:45 INFO - PROCESS | 20017 | 23:29:46 INFO - PROCESS | 20017 | Cycle 1(1): loaded http://localhost:36969/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36969/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:29:47 INFO - PROCESS | 20017 | RSS: Main: 210104320 23:29:47 INFO - PROCESS | 20017 | 23:29:49 INFO - PROCESS | 20017 | Cycle 1(1): loaded http://localhost:36969/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36969/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:29:50 INFO - PROCESS | 20017 | RSS: Main: 217296896 23:29:50 INFO - PROCESS | 20017 | 23:29:52 INFO - PROCESS | 20017 | Cycle 1(1): loaded http://localhost:36969/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36969/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:29:53 INFO - PROCESS | 20017 | RSS: Main: 221859840 23:29:53 INFO - PROCESS | 20017 | 23:29:56 INFO - PROCESS | 20017 | Cycle 1(1): loaded http://localhost:36969/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36969/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:29:56 INFO - PROCESS | 20017 | RSS: Main: 223186944 23:29:56 INFO - PROCESS | 20017 | 23:29:58 INFO - PROCESS | 20017 | Cycle 1(1): loaded http://localhost:36969/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36969/tests/kraken/driver.html?testName=ai-astar) 23:29:58 INFO - PROCESS | 20017 | RSS: Main: 265175040 23:29:58 INFO - PROCESS | 20017 | 23:29:58 INFO - PROCESS | 20017 | __start_tp_report 23:29:58 INFO - PROCESS | 20017 | _x_x_mozilla_page_load 23:29:58 INFO - PROCESS | 20017 | _x_x_mozilla_page_load_details 23:29:58 INFO - PROCESS | 20017 | |i|pagename|runs| 23:29:58 INFO - PROCESS | 20017 | |0;ai-astar;111;105;110;109;110;111;111;110;111;114 23:29:58 INFO - PROCESS | 20017 | |1;audio-beat-detection;157;131;129;175;127;154;155;129;185;136 23:29:58 INFO - PROCESS | 20017 | |2;audio-dft;159;160;160;160;160;160;161;162;162;161 23:29:58 INFO - PROCESS | 20017 | |3;audio-fft;76;73;75;115;74;76;75;75;99;74 23:29:58 INFO - PROCESS | 20017 | |4;audio-oscillator;82;82;106;82;83;83;122;83;83;120 23:29:58 INFO - PROCESS | 20017 | |5;imaging-gaussian-blur;116;117;116;116;117;117;118;117;117;117 23:29:58 INFO - PROCESS | 20017 | |6;imaging-darkroom;145;146;146;145;146;146;146;145;145;146 23:29:58 INFO - PROCESS | 20017 | |7;imaging-desaturate;94;94;95;95;95;95;95;95;94;95 23:29:58 INFO - PROCESS | 20017 | |8;json-parse-financial;55;56;56;55;56;56;57;56;55;55 23:29:58 INFO - PROCESS | 20017 | |9;json-stringify-tinderbox;62;63;61;62;61;62;61;62;62;63 23:29:58 INFO - PROCESS | 20017 | |10;stanford-crypto-aes;78;79;84;80;83;81;79;81;115;87 23:29:58 INFO - PROCESS | 20017 | |11;stanford-crypto-ccm;122;131;120;119;118;128;128;120;130;130 23:29:58 INFO - PROCESS | 20017 | |12;stanford-crypto-pbkdf2;160;165;161;161;159;163;162;162;169;161 23:29:58 INFO - PROCESS | 20017 | |13;stanford-crypto-sha256-iterative;63;64;64;63;62;62;65;63;61;60 23:29:58 INFO - PROCESS | 20017 | __end_tp_report 23:29:58 INFO - PROCESS | 20017 | __start_cc_report 23:29:58 INFO - PROCESS | 20017 | _x_x_mozilla_cycle_collect,1608 23:29:58 INFO - PROCESS | 20017 | __end_cc_report 23:29:58 INFO - PROCESS | 20017 | __startTimestamp1464762598604__endTimestamp 23:29:58 INFO - PROCESS | 20017 | 23:29:58 INFO - PROCESS | 20017 | ------- Summary: start ------- 23:29:58 INFO - PROCESS | 20017 | Number of tests: 14 23:29:58 INFO - PROCESS | 20017 | 23:29:58 INFO - PROCESS | 20017 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:2.25 (2.0%) stddev-sans-first:2.37 23:29:58 INFO - PROCESS | 20017 | Values: 111.0 105.0 110.0 109.0 110.0 111.0 111.0 110.0 111.0 114.0 23:29:58 INFO - PROCESS | 20017 | 23:29:58 INFO - PROCESS | 20017 | [#1] audio-beat-detection Cycles:10 Average:147.80 Median:154.50 stddev:20.71 (13.4%) stddev-sans-first:21.70 23:29:58 INFO - PROCESS | 20017 | Values: 157.0 131.0 129.0 175.0 127.0 154.0 155.0 129.0 185.0 136.0 23:29:58 INFO - PROCESS | 20017 | 23:29:58 INFO - PROCESS | 20017 | [#2] audio-dft Cycles:10 Average:160.50 Median:160.50 stddev:0.97 (0.6%) stddev-sans-first:0.87 23:29:58 INFO - PROCESS | 20017 | Values: 159.0 160.0 160.0 160.0 160.0 160.0 161.0 162.0 162.0 161.0 23:29:58 INFO - PROCESS | 20017 | 23:29:58 INFO - PROCESS | 20017 | [#3] audio-fft Cycles:10 Average:81.20 Median:75.00 stddev:14.14 (18.9%) stddev-sans-first:14.87 23:29:58 INFO - PROCESS | 20017 | Values: 76.0 73.0 75.0 115.0 74.0 76.0 75.0 75.0 99.0 74.0 23:29:58 INFO - PROCESS | 20017 | 23:29:58 INFO - PROCESS | 20017 | [#4] audio-oscillator Cycles:10 Average:92.60 Median:82.50 stddev:16.67 (20.2%) stddev-sans-first:17.23 23:29:58 INFO - PROCESS | 20017 | Values: 82.0 82.0 106.0 82.0 83.0 83.0 122.0 83.0 83.0 120.0 23:29:58 INFO - PROCESS | 20017 | 23:29:58 INFO - PROCESS | 20017 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 23:29:58 INFO - PROCESS | 20017 | Values: 116.0 117.0 116.0 116.0 117.0 117.0 118.0 117.0 117.0 117.0 23:29:58 INFO - PROCESS | 20017 | 23:29:58 INFO - PROCESS | 20017 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 23:29:58 INFO - PROCESS | 20017 | Values: 145.0 146.0 146.0 145.0 146.0 146.0 146.0 145.0 145.0 146.0 23:29:58 INFO - PROCESS | 20017 | 23:29:58 INFO - PROCESS | 20017 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 23:29:58 INFO - PROCESS | 20017 | Values: 94.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 23:29:58 INFO - PROCESS | 20017 | 23:29:58 INFO - PROCESS | 20017 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:56.00 stddev:0.67 (1.2%) stddev-sans-first:0.67 23:29:58 INFO - PROCESS | 20017 | Values: 55.0 56.0 56.0 55.0 56.0 56.0 57.0 56.0 55.0 55.0 23:29:58 INFO - PROCESS | 20017 | 23:29:58 INFO - PROCESS | 20017 | [#9] json-stringify-tinderbox Cycles:10 Average:61.90 Median:62.00 stddev:0.74 (1.2%) stddev-sans-first:0.78 23:29:58 INFO - PROCESS | 20017 | Values: 62.0 63.0 61.0 62.0 61.0 62.0 61.0 62.0 62.0 63.0 23:29:58 INFO - PROCESS | 20017 | 23:29:58 INFO - PROCESS | 20017 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:81.00 stddev:10.99 (13.6%) stddev-sans-first:11.38 23:29:58 INFO - PROCESS | 20017 | Values: 78.0 79.0 84.0 80.0 83.0 81.0 79.0 81.0 115.0 87.0 23:29:58 INFO - PROCESS | 20017 | 23:29:58 INFO - PROCESS | 20017 | [#11] stanford-crypto-ccm Cycles:10 Average:124.60 Median:128.00 stddev:5.23 (4.1%) stddev-sans-first:5.46 23:29:58 INFO - PROCESS | 20017 | Values: 122.0 131.0 120.0 119.0 118.0 128.0 128.0 120.0 130.0 130.0 23:29:58 INFO - PROCESS | 20017 | 23:29:58 INFO - PROCESS | 20017 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.30 Median:162.00 stddev:2.87 (1.8%) stddev-sans-first:2.92 23:29:58 INFO - PROCESS | 20017 | Values: 160.0 165.0 161.0 161.0 159.0 163.0 162.0 162.0 169.0 161.0 23:29:58 INFO - PROCESS | 20017 | 23:29:58 INFO - PROCESS | 20017 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:63.00 stddev:1.49 (2.4%) stddev-sans-first:1.58 23:29:58 INFO - PROCESS | 20017 | Values: 63.0 64.0 64.0 63.0 62.0 62.0 65.0 63.0 61.0 60.0 23:29:58 INFO - PROCESS | 20017 | -------- Summary: end -------- 23:29:58 INFO - PROCESS | 20017 | 23:29:59 INFO - TEST-INFO | 20017: exit 0 23:29:59 INFO - TEST-OK | kraken | took 60282ms 23:29:59 INFO - SUITE-END | took 1172s 23:29:59 INFO - Completed test suite (00:19:32) 23:29:59 INFO - javascript benchmark 23:29:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3095.4737694591918, 3102.1314032071, 3128.671489493604, 3129.499280115182, 3163.2250098725817, 5279.392869819972, 5295.549878260343, 5336.252924590555, 5367.543758780498, 5407.2700185475, 5317.9468205317935, 5337.306150200478, 5372.059889519328, 5388.649737767042, 5389.6496727712765, 4831.951680483203, 4847.903041939177, 4902.362692849924, 4903.509649035103, 5075.492450754932, 4984.202527595586, 5004.924926126111, 5050.595952323805, 5051.0403023425615, 5062.987402519492, 4773.57037866592, 4808.495108013643, 4813.085513752376, 4830.106430310386, 4871.780769865364, 4797.64017698674, 4799.376081109468, 4882.121218180726, 4884.218525035977, 4920.75396230187, 4746.738929358884, 4813.109574728686, 4834.7824347904425, 4842.878928026792, 4876.634252431082, 5246.291750613695, 5320.5211530962015, 5333.35999680037, 5420.105682562412, 5428.511433970922, 5797.246357973479, 5800.332961709415, 5828.242328497311, 5831.387704291031, 5835.649861008311, 5631.5776316776, 5642.294713160855, 5838.241028666289, 5850.853728656775, 5853.5902486825935, 5273.762680679379, 5392.514673679309, 5393.352797664266, 5393.703346315951, 5394.298741163623, 5898.144769008555, 5900.7049647518315, 5901.02633065548, 5906.055031194988, 5907.645541267538, 5488.1493368527945, 5544.390117087117, 5574.108142697149, 5666.376698563155, 5668.206451096849, 5711.428857114339, 5718.828435146952, 5724.8282551523525, 5728.971355143198, 5732.570057245724, 5678.659280443187, 5717.113847353667, 5721.5136713379825, 5721.742521586539, 5726.055200891889, 5615.0454422748235, 5664.0, 5670.829875103754, 5692.203091567184, 5706.600537962386, 4391.604755572014, 4395.318725597537, 4396.890077748082, 4397.494288156903, 4432.623227025739, 3915.4126880967515, 3926.469926559935, 3942.8817135485983, 3971.4042893566198, 3988.441618173458, 5290.259363689087, 5293.12663410533, 5358.97320513395, 5405.027095122837, 5409.945900540944, 5752.856178595569, 5755.625884317506, 5756.453136951983, 5768.048272035067, 5790.826275211751, 5416.783328666888, 5423.566114710814, 5423.620346575781, 5427.48438898304, 5432.212329212242, 4833.540813622701, 4931.802727890916, 4962.528559786814, 4970.776315065831, 4971.676841005323, 6012.368701286389, 6015.969920150459, 6017.157597936292, 6018.398160183947, 6020.69896505173, 5783.4794868461195, 5792.768289268382, 5793.565482588739, 5797.246357973437, 5821.126830975388, 5800.9419905800405, 5945.524358051432, 5974.342822289632, 6011.549133814894, 6065.696715164312, 5717.256756621613, 5757.107648314518, 5759.0, 5766.250387449605, 5773.942260577509, 5652.0, 5760.049591817471, 5795.768169273182, 5799.9130013049, 5812.0, 5642.0, 5700.857478562903, 5704.458076482728, 5735.053716136791, 5740.885182296414, 5687.886242275049, 5698.943010569841, 5705.37240903492, 5708.0, 5709.885802284014, 5357.651752636066, 5474.288342515448, 5596.3284405871555, 5608.691521966331, 5615.185798059177, 5630.5214056805635, 5742.856428589319, 5749.051406518045, 5752.9712351437975, 5755.5683323750045, 5505.174223866452, 5510.889782204414, 5529.529989950899, 5541.861453463695, 5554.50009499147], "value": 5306.293931149006, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.7991118629731, 580.4949693766423, 592.437184674559, 603.3739073197728, 608.2305883057933, 32685.50971735426, 35629.10927226821, 42922.0, 44196.0, 44246.557534424646, 45481.0, 45937.99999999992, 45942.54057459424, 46059.769701151534, 46075.0, 8789.340799440051, 8958.32812539059, 8985.775355616097, 8991.95504022479, 8994.550272486349, 8722.30221582272, 8808.603612837438, 8832.911670883273, 8838.779030524256, 8841.60212790426, 8847.690330838423, 8897.0, 8919.0, 8919.063498332678, 8919.063498332678, 8841.646334146659, 8885.644574217089, 8887.0, 8887.866681999774, 8889.199972002518, 8643.438176518506, 8681.088485709037, 8737.912620873774, 8747.256483198937, 8752.431091979, 42447.57552424498, 42710.35934460985, 42752.78623606893, 42888.57111428877, 42893.14213715708, 3404.8297585120645, 3416.231347946717, 3699.7995694454594, 4108.465899433085, 4179.540250572434, 32232.355352893046, 32506.18734531632, 33101.0, 33542.0, 33729.0, 4427.092446048552, 4429.468463784334, 4472.284434490499, 4510.0, 4574.382458368111, 317004.0, 321548.0, 325291.0, 325341.0, 325971.0, 53447.732761335945, 59035.40964590299, 59346.406535934955, 59603.0, 59676.0, 62356.376436235965, 63597.0, 64215.35784642187, 68253.0, 68636.0, 16077.758833617505, 16185.0, 16203.270852811651, 16243.918780406022, 16264.268107935171, 10906.781864362669, 10935.125189984783, 10941.45292735376, 10945.23383363157, 10975.176861735401, 18105.0, 18180.818191818176, 18221.817781822276, 18301.816981830278, 18336.0, 6239.563230573816, 6409.436864499935, 6428.582142160744, 6450.387213214737, 6490.545661803629, 906.5150144672568, 988.8417853143607, 1082.7996820588216, 1100.3178029621686, 1134.2098437842833, 31989.52015719766, 32676.509852352232, 33391.0, 34512.270107328826, 35002.199824014526, 840.2143995364354, 1096.1231015187818, 1130.3444002478543, 1171.800793865045, 1193.665773583398, 16412.261448234858, 16458.0, 16478.2584783685, 16525.83474165243, 16532.504024879272, 494552.0, 499818.0, 500575.0, 500914.0, 504152.0, 57700.42299577034, 58035.12947305794, 58054.0, 58108.709456452445, 58201.12698309529, 1224.9142560020891, 1342.9664258393618, 1369.1442848219863, 1369.301656155348, 1378.7587172244816, 31758.364832702755, 32793.34413311768, 32885.342293154485, 33016.33967320592, 33231.33537329191, 44685.776571116934, 44738.0, 44922.550774491836, 45135.54864451313, 45149.77425112853, 378461.0, 379002.0, 380716.0, 381686.0, 425175.0, 26995.325116872235, 27790.637795787585, 28152.85923570451, 29069.27326816762, 29320.0, 47336.7633161832, 48037.75981120072, 48422.273665895744, 49013.50986490232, 49722.75138624284, 40135.79932100321, 41233.0, 41390.37914431225, 41570.4548962202, 42341.1531769369, 39778.0, 40087.1982560353, 40609.390859137726, 41012.38481422721, 41274.38088428616, 39500.604993949695, 39639.603603964744, 39936.80031599823, 40518.59481405266, 40827.59172408238, 34981.82509087438, 36201.27597447984, 36858.0, 36988.44517332296, 37309.81345093257, 27454.5881811769, 27476.0, 27696.0, 28030.2992425191, 28072.719272807826], "value": 19777.385297666606, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.6301752502509, 399.56447472255235, 399.96400323970846, 401.221630037727, 418.22419411990757, 18259.543511412223, 19558.119884605192, 19642.705359419604, 19654.0, 20602.278920237793, 18312.175952082154, 18898.622027559475, 19127.42617721467, 19228.519287017833, 19435.416937491864, 5217.921731174045, 5251.921221181686, 5312.0, 5344.198370244475, 5349.8127565535215, 5249.107651699221, 5295.258663787073, 5298.4436634153435, 5299.629025968184, 5317.229001794737, 5224.947750522484, 5232.502912223333, 5285.154375299952, 5297.655652382583, 5299.973500132513, 5262.7631756571045, 5287.4448182941005, 5300.708461034642, 5307.734613269321, 5336.786528538853, 5039.924401133986, 5160.638755287131, 5344.9732751336, 5350.812721554766, 5427.240186373911, 13597.0, 13908.095973761774, 13990.790138147935, 14000.159990400609, 14059.578212653534, 2112.2607087519245, 2133.4453042208984, 2225.955480890373, 2234.2515257388795, 2297.9888848906426, 9862.802743945153, 9957.302988790787, 10045.799084018352, 10324.58701651933, 10482.633107841266, 1818.5635447492639, 1823.4894229615595, 1916.7124931260282, 1940.078462730206, 1955.628430598196, 83783.58108209481, 85664.14335856625, 86619.56690216508, 86778.0, 88081.55959220228, 10975.341479511255, 10975.890241097646, 11051.778964420666, 11088.33469991803, 11190.32858028521, 15846.841531584767, 15984.520464386087, 16060.919695401448, 16066.27701753424, 16070.919645401931, 7350.2649735027135, 7607.429442791813, 7689.461737678421, 7815.92184078152, 7839.529628222325, 6770.221424536241, 6910.0, 6921.48088893335, 6927.0, 7266.890996635055, 4728.101660684459, 4753.001869607352, 4804.8318308859725, 4891.559759621651, 4939.506049395103, 1945.0, 1979.5249140206247, 1981.9009049547465, 2020.6867935470025, 2051.415346626204, 903.3676426501476, 961.9759506012266, 982.4891056650501, 1075.172117469544, 1094.4637127807316, 19423.91585824976, 19772.60454790925, 19944.70082948757, 19999.800002000084, 20084.89957550203, 971.1114330387617, 1000.4247557654378, 1013.6350913671073, 1033.8449232615017, 1036.5698235232294, 8860.778480537909, 10919.181061420266, 11004.339739615489, 11096.667099987013, 11127.833082503768, 411318.0, 507163.0, 517506.0, 518046.0, 534384.0, 97542.0, 99124.50437747766, 101925.0, 102269.0, 102585.48707256417, 963.0658261486348, 991.494337887668, 1000.8698869146964, 1021.2289721260549, 1021.2493817044466, 16458.0, 17244.74132888033, 17281.56796080108, 18148.183331750366, 18464.07679615987, 32457.35085298328, 34583.30833383369, 42190.36714449347, 43580.34629480497, 44808.551914480435, 59562.0, 60329.39670603413, 62383.37616623957, 62515.6874215626, 62910.685446572475, 8730.781730456789, 8841.027486976556, 8940.374173808032, 9052.773680658036, 9122.543872806466, 10051.899481005097, 14010.789838152232, 14108.576742697736, 14351.85648143547, 14367.066140700821, 11963.641090766943, 12100.515979360727, 12111.091668125102, 12244.693882653006, 12359.25844449336, 11723.41382930867, 11787.587434439753, 12053.51785928553, 12115.394230288273, 12306.200096993667, 12262.528496580468, 12397.690057748629, 12567.748645027232, 12583.307918064595, 12702.237865728086, 8735.912640873765, 8738.650453981769, 8941.508217048126, 9040.452768632485, 9239.72280831576, 8983.236424903957, 11314.60398886035, 12090.395480226129, 12357.443915024025, 12497.37513124322], "value": 9062.751890402353, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1309.6529419703775, 1433.448122472848, 1493.186213513635, 1582.2326171806671, 1798.2177752677587, 8198.713045043425, 8440.788980275496, 8551.828963420729, 8672.0, 8749.168828961254, 8462.449940753846, 8710.346723995694, 8726.607302671378, 8731.257843083346, 8756.824863502741, 1998.2806189771743, 2043.5402034542258, 2052.148358431249, 2363.3973336799136, 2392.9710224603414, 2347.248880358286, 2404.927852164429, 2409.8433601815827, 2422.0675040109595, 2430.295214387834, 2336.766323367658, 2345.3784747042046, 2354.0, 2356.1871154451687, 2386.2364043506, 2000.0599718132455, 2201.5046614511766, 2366.100881664965, 2401.8198635102435, 2405.0980882169188, 2285.0745448093385, 2327.8603283803027, 2330.557194133109, 2333.0900948630047, 2333.988330058356, 8376.748697539084, 8446.450980686235, 8464.44981076228, 8466.449680770791, 8469.237768600855, 5133.332666753336, 5221.582273418156, 5231.712255825928, 5264.052470555299, 5265.763040663141, 3183.6338821035647, 3321.667833216683, 3513.350030244413, 3517.050396392985, 3541.698955588778, 1161.1523587780882, 1169.7192673758236, 1175.3183153770879, 1222.4865556466304, 1232.4577186038205, 11771.7057073573, 11791.528338866436, 11869.228500147548, 11869.703257418547, 11875.762484750343, 4634.629229661619, 4650.442101895836, 4755.690880092783, 4785.377900872864, 4793.01743142655, 10087.596496140219, 10093.192544596415, 10100.797984040279, 10114.54484548197, 10115.645952391631, 5119.078565858182, 5171.146760784503, 5172.405173405032, 5174.663646862942, 5178.870528236825, 4211.515675697273, 4657.813687452532, 4804.615630749532, 4824.842037910876, 4877.219644856806, 3897.8830635080994, 3947.802609869495, 3968.6428221460205, 4013.979930100331, 4032.91934161321, 1221.4381384563023, 1240.2682417373792, 1241.3544956622507, 1260.3446207971804, 1276.2342594443446, 994.8955359687128, 995.2038369304528, 996.7956568903357, 1004.5178314409125, 1006.5168719014914, 5895.233619629421, 5935.851603709942, 5946.910796338058, 6134.570580059442, 6170.167027451326, 414.21506245664295, 448.6836780070043, 449.8942748454111, 450.3155204089765, 450.5832105302582, 4293.377460268243, 4293.69944103916, 4347.478302603708, 4359.825606975685, 4416.933745993812, 10374.325668831501, 10817.080548153337, 10857.891421085846, 10871.565137394573, 10881.292715973437, 10778.622748203776, 10784.460776961121, 10796.406197659204, 10803.891961080288, 10805.0, 7644.847103057908, 7990.68037278514, 7996.760097196977, 8074.354051675852, 8145.0, 5904.675242861684, 6031.939680603138, 6087.969560152171, 6250.124982502544, 6273.121762953099, 9916.752081198028, 9961.701148965543, 10109.342892712244, 10117.08946194846, 10126.645567405105, 9981.201503879527, 10039.096481316716, 10109.949450252701, 10133.797324053625, 10405.219608529542, 7055.506114571931, 7591.3547348475995, 7762.223777622193, 7806.336461400844, 7964.084130324855, 8442.53566053873, 8458.154184581492, 8471.4493557921, 8502.82994340122, 8512.233898949124, 7480.251974802476, 7681.923180768121, 7771.611419429119, 7880.802979925547, 7918.604069796603, 7618.504797188165, 7627.084749830056, 7644.197359277196, 7809.492382995087, 7812.140664526783, 6608.471322294109, 6643.236027856665, 6673.699683514156, 6682.3317668232785, 6682.599044057372, 5142.8971420572125, 5176.352955880515, 5225.216217567396, 5379.946200537945, 5396.9460305398015, 5169.4830516948, 5216.478352164753, 5288.524032837063, 5331.1470164773455, 5335.546478549367], "value": 4531.95337956029, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.50135217656805, 334.9949750753738, 341.5593883889782, 341.992831112374, 345.3076581454185, 5270.65740726853, 5327.893442131155, 5342.332208473941, 5350.2777125088105, 5358.91961620576, 4940.431850337212, 5150.17168905038, 5159.226116082589, 5164.561012313958, 5261.710605916673, 4018.97990510047, 4098.200850834096, 4168.478940132483, 4178.937315940263, 4206.1377417629465, 4152.466995132966, 4160.0, 4174.749515029092, 4186.5813418658045, 4188.308929026707, 4037.4347591337237, 4083.3466645336753, 4168.728537795971, 4183.916321673565, 4193.895152621194, 3942.8225729842084, 4032.657224135937, 4138.441310423084, 4149.854755083557, 4151.0, 3705.4441833724886, 3706.5552133743854, 3713.2573485303046, 3716.2753263113705, 3726.9813650931574, 5062.911474033101, 5105.846824595268, 5114.718690472023, 5126.897462050775, 5133.743312834381, 4631.374764406829, 4712.58622413278, 4738.336632871401, 4743.525647435264, 4753.881152971168, 5460.5085542300985, 5476.507114359727, 5487.807926722586, 5496.587755918322, 5514.80698175566, 4033.233685599727, 4033.9596604033877, 4049.574794646549, 4058.3506638937924, 4068.735532190428, 5538.667679939216, 5651.0, 5690.374058853523, 5692.402297758758, 5741.650712082657, 4141.855035073758, 4151.0, 4158.064435501988, 4165.375193720966, 4178.623923846869, 4211.55778643238, 4217.367394890791, 4221.472315960505, 4221.746695198298, 4222.239996800606, 4618.630509559227, 4715.622750180046, 4725.125851717443, 4737.360456338419, 4756.0, 5470.56235501159, 5540.279763630783, 5540.556755459554, 5543.279373681396, 5558.388577256498, 1427.0, 1446.4503488674236, 1457.7099267148649, 1459.839417664056, 1462.926853657313, 910.1853840812436, 955.285262953001, 956.1681337236648, 957.8850537935353, 965.7537327981461, 4730.107956817232, 4769.308450274691, 4778.378810754649, 4805.471398146201, 4827.227643577011, 4981.252812078144, 5010.473900240495, 5015.3480047593575, 5024.346834911511, 5031.0, 4765.761711914391, 4770.833020844323, 4832.44426890912, 4992.251162325608, 5096.668716533413, 2988.2977500287416, 3034.2111051126426, 3050.2984313607994, 3054.106453998535, 3056.449839028952, 5843.211166492469, 5843.328017277982, 5857.238558987389, 5887.8233652990475, 5887.882242355129, 5638.182463542763, 5750.0, 5805.622634528742, 5822.8354329134345, 5828.213191219216, 5827.912581311199, 5893.499052580493, 5897.852553686193, 5900.911486327708, 5946.8810623787285, 5582.86042848932, 5629.802956896653, 5715.114157305624, 5716.342620598518, 5717.37108918027, 5540.4763689985575, 5585.301837270341, 5635.351934527582, 5638.520725738194, 5656.830295090989, 5824.94175058244, 5873.765049397976, 5883.941160588511, 5888.735006924784, 5896.941030589639, 3828.5597156326266, 4114.506259248909, 4117.970507373157, 4172.4993000840095, 4177.58224177592, 5700.942990570207, 5715.542756579381, 5719.7426115824055, 5721.399253078367, 5736.013470637867, 5546.0, 5556.972215138899, 5588.854284871511, 5591.217229587943, 5594.356648985418, 5420.593455490933, 5448.863778405572, 5554.0, 5559.63862348946, 5567.802922371709, 5374.677519348852, 5397.568194544348, 5409.567234621142, 5429.837104886859, 5450.918236226539, 5322.627416080837, 5426.236473146164, 5487.490939991534, 5504.2018907257425, 5623.465770751772, 5466.426025267289, 5479.726013699379, 5493.478119578634, 5493.890122197454, 5524.944750552443], "value": 4209.719862835199, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [730.9159446663633, 765.169790777007, 852.8550146475098, 856.3406177243522, 878.6573236437787, 14399.424023039066, 15072.095674259552, 15262.93159478837, 15279.541613751606, 15292.617684557892, 13750.793738093937, 14509.637259068528, 14516.854831451683, 14519.0, 14535.345909434074, 826.9669213231464, 833.2625626320689, 833.8040560468285, 839.1105428246078, 839.9622017009249, 696.5994553131944, 814.4828034198267, 824.2169938558363, 838.0990435282066, 841.9242268195861, 867.7960679240374, 871.6905498548019, 871.8387098386787, 872.6422166911567, 873.6243415331405, 865.3336930563494, 866.6879923227633, 869.5087275689216, 869.5478351257342, 869.7173418638936, 528.8545649946257, 614.7602435050334, 630.5145038320513, 630.8422894276431, 632.7627139822566, 14895.478658247017, 14918.70162596753, 14920.701585968329, 14922.403103875831, 14923.030003049875, 13452.663683407894, 13827.446902124004, 13918.37367318463, 13994.300284985811, 14116.435342586386, 11974.161808673396, 12078.818817717653, 12212.572559960448, 12236.449359778831, 12269.631911042683, 4452.176347375714, 4462.709923854972, 4514.774261286955, 4554.567316104998, 4576.954230457686, 57825.0, 58074.70962645202, 58093.41906580965, 58127.709361453344, 58484.99999999958, 11103.83344249837, 11191.160662950311, 11192.216544841784, 11225.775484490265, 11257.71855703614, 19663.803361966482, 19701.704474432896, 19714.802851971584, 19734.70397944032, 19750.604987900162, 8077.27304542594, 8507.27688146502, 8527.317814574819, 8612.224899758927, 8707.695230666895, 4640.65195110368, 4794.472608013116, 4813.831515896997, 4893.412790465167, 4897.608191344755, 3405.1997780521556, 3412.0616830371846, 3476.8261586921058, 3478.4434490481403, 3480.89557313281, 650.2814390098968, 655.1090516897016, 655.9606423614503, 657.2080642825384, 657.8585604095142, 613.2058983616228, 654.6203202142746, 738.5015114797491, 744.5309455043288, 753.3031945450437, 9104.590293436811, 9658.32391732586, 9737.513124343754, 9755.219582433388, 9762.316637835425, 698.3121625199175, 718.256604414439, 722.8012296618367, 741.4513260187423, 752.5710345103348, 4438.400815889878, 4687.414073240845, 4693.366395536627, 4696.342512048316, 4723.362346083235, 65300.0, 66539.66730166414, 67045.66477167583, 68191.0, 68295.3170468289, 58936.410635893095, 60137.699311503166, 60192.0, 60978.39021609727, 62110.37889621136, 53053.46946530562, 53096.0, 53103.468965309854, 54224.45775542273, 55282.0, 8830.735077947671, 8862.335324850534, 8969.37214394986, 8971.685990990283, 9118.452892826452, 35871.64128358787, 36621.0, 36810.079748006516, 37061.0, 37168.25663486769, 45700.771496142304, 46448.30327545022, 48120.27819582779, 49388.50611493839, 49514.25728614002, 11318.717032073935, 11350.148738844455, 11465.656030319104, 11856.347900865536, 13275.933620331836, 12448.81326780081, 12676.683082923, 12685.492580296685, 12767.170133941265, 12994.415251313525, 11815.940920295343, 12107.273563586214, 12133.453994570089, 12289.201201921847, 12298.077644176901, 11540.94229528847, 11975.520979160736, 12097.879021210027, 12477.572256068639, 12578.55975040869, 11790.0, 12498.812517812059, 12624.621261362174, 12628.11603187768, 12637.052221083271, 9938.936603286558, 10344.586216551254, 10356.53395597215, 10398.376097434179, 10448.268621196443, 9703.805923881624, 9969.900300997188, 10078.496075196357, 10709.0, 10747.46262686847], "value": 6910.7515069092915, "unit": "score"}], "name": "dromaeo_css", "value": 7074.920583109674, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 105.0, 110.0, 109.0, 110.0, 111.0, 111.0, 110.0, 111.0, 114.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 131.0, 129.0, 175.0, 127.0, 154.0, 155.0, 129.0, 185.0, 136.0], "value": 147.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 160.0, 160.0, 160.0, 160.0, 160.0, 161.0, 162.0, 162.0, 161.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 73.0, 75.0, 115.0, 74.0, 76.0, 75.0, 75.0, 99.0, 74.0], "value": 81.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 106.0, 82.0, 83.0, 83.0, 122.0, 83.0, 83.0, 120.0], "value": 92.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 56.0, 55.0, 56.0, 56.0, 57.0, 56.0, 55.0, 55.0], "value": 55.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 61.0, 62.0, 61.0, 62.0, 61.0, 62.0, 62.0, 63.0], "value": 61.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 84.0, 80.0, 83.0, 81.0, 79.0, 81.0, 115.0, 87.0], "value": 84.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 131.0, 120.0, 119.0, 118.0, 128.0, 128.0, 120.0, 130.0, 130.0], "value": 124.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 165.0, 161.0, 161.0, 159.0, 163.0, 162.0, 162.0, 169.0, 161.0], "value": 162.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 63.0, 62.0, 62.0, 65.0, 63.0, 61.0, 60.0], "value": 62.7, "unit": "score"}], "name": "kraken", "value": 1501.3, "alertThreshold": 2.0}]} 23:29:59 INFO - Return code: 0 23:29:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:29:59 ERROR - # TBPL SUCCESS # 23:29:59 INFO - Running post-action listener: _resource_record_post_action 23:29:59 INFO - ##### 23:29:59 INFO - ##### Finished run-tests step (success) 23:29:59 INFO - ##### 23:29:59 INFO - Running post-run listener: _resource_record_post_run 23:30:00 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 543805440; Read time: 12; Write time: 401688 23:30:00 INFO - TinderboxPrint: CPU usage
13.1% 23:30:00 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 23:30:00 INFO - TinderboxPrint: I/O write bytes / time
543,805,440 / 401,688 23:30:00 INFO - TinderboxPrint: CPU idle
8,249.1 (86.8%) 23:30:00 INFO - TinderboxPrint: CPU user
1,206.8 (12.7%) 23:30:00 INFO - TinderboxPrint: Swap in / out
0 / 0 23:30:00 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 244277248; Read time: 0; Write time: 228840 23:30:00 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 296329216; Read time: 12; Write time: 172280 23:30:00 INFO - Running post-run listener: _upload_blobber_files 23:30:00 INFO - Blob upload gear active. 23:30:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:30:00 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 23:30:00 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:30:00 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:30:00 INFO - (blobuploader) - INFO - Open directory for files ... 23:30:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:30:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:30:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:30:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:30:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:30:01 INFO - (blobuploader) - INFO - Done attempting. 23:30:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:30:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:30:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:30:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:30:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:30:05 INFO - (blobuploader) - INFO - Done attempting. 23:30:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:30:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:30:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:30:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:30:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:30:06 INFO - (blobuploader) - INFO - Done attempting. 23:30:06 INFO - (blobuploader) - INFO - Iteration through files over. 23:30:06 INFO - Return code: 0 23:30:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:30:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:30:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a065352388797087965bb69b2c7f2ae11161269fcaad27ff94c0a8a1905646b4330db095c0c5ddff6176959d93dac4513fc2a429d70a6b41fdd223aa39975ab5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e8c9183a72f9b86f8ec91454e3d188881b9e126f63fdf5e50c90a1135f79323a967c91bc1d9a1bf13f51e64ad1c229ac4bb2f1f19f11e135d1c1fcf19c745434", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4dd19e9d6f2fbfb8837ae990f6f3bb91d0d1e4eaa929de0b101cff704099a2e1c608e1204f4129eba44461a7121dc97df4875f9dc01f8e90e76445bb344f01bd"} 23:30:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:30:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:30:06 INFO - Contents: 23:30:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a065352388797087965bb69b2c7f2ae11161269fcaad27ff94c0a8a1905646b4330db095c0c5ddff6176959d93dac4513fc2a429d70a6b41fdd223aa39975ab5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e8c9183a72f9b86f8ec91454e3d188881b9e126f63fdf5e50c90a1135f79323a967c91bc1d9a1bf13f51e64ad1c229ac4bb2f1f19f11e135d1c1fcf19c745434", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4dd19e9d6f2fbfb8837ae990f6f3bb91d0d1e4eaa929de0b101cff704099a2e1c608e1204f4129eba44461a7121dc97df4875f9dc01f8e90e76445bb344f01bd"} 23:30:06 INFO - Running post-run listener: copy_logs_to_upload_dir 23:30:06 INFO - Copying logs to upload dir... 23:30:06 INFO - mkdir: /builds/slave/test/build/upload/logs 23:30:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.595701 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-05-31 23:30:06.025865) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-31 23:30:06.029160) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1464759983.559522-856082644 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/sha512/a065352388797087965bb69b2c7f2ae11161269fcaad27ff94c0a8a1905646b4330db095c0c5ddff6176959d93dac4513fc2a429d70a6b41fdd223aa39975ab5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e8c9183a72f9b86f8ec91454e3d188881b9e126f63fdf5e50c90a1135f79323a967c91bc1d9a1bf13f51e64ad1c229ac4bb2f1f19f11e135d1c1fcf19c745434", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4dd19e9d6f2fbfb8837ae990f6f3bb91d0d1e4eaa929de0b101cff704099a2e1c608e1204f4129eba44461a7121dc97df4875f9dc01f8e90e76445bb344f01bd"} build_url:https://queue.taskcluster.net/v1/task/RYuzWjGEQ76cjRlV_AQgEQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011438 build_url: 'https://queue.taskcluster.net/v1/task/RYuzWjGEQ76cjRlV_AQgEQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a065352388797087965bb69b2c7f2ae11161269fcaad27ff94c0a8a1905646b4330db095c0c5ddff6176959d93dac4513fc2a429d70a6b41fdd223aa39975ab5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e8c9183a72f9b86f8ec91454e3d188881b9e126f63fdf5e50c90a1135f79323a967c91bc1d9a1bf13f51e64ad1c229ac4bb2f1f19f11e135d1c1fcf19c745434", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4dd19e9d6f2fbfb8837ae990f6f3bb91d0d1e4eaa929de0b101cff704099a2e1c608e1204f4129eba44461a7121dc97df4875f9dc01f8e90e76445bb344f01bd"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-31 23:30:06.055251) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 23:30:06.055714) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1464759983.559522-856082644 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004428 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-31 23:30:06.138776) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-31 23:30:06.139132) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-31 23:30:06.139457) ========= ========= Total master_lag: 0.21 =========