builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-066 starttime: 1465251632.47 results: success (0) buildid: 20160606144730 builduid: 7d1be82600d0474ea302f641b8808734 revision: f10a5cdcf8a1b908bf2c25f15cc4c8e9df11addd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 15:20:32.467859) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 15:20:32.468341) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 15:20:32.468630) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 15:20:32.479783) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 15:20:32.480062) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1465251632.247339-392662337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-06 15:20:32-- 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% 112M=0s 2016-06-06 15:20:32 (112 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.107695 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 15:20:32.601685) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 15:20:32.602030) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1465251632.247339-392662337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018296 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 15:20:32.651336) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 15:20:32.651755) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f10a5cdcf8a1b908bf2c25f15cc4c8e9df11addd --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 f10a5cdcf8a1b908bf2c25f15cc4c8e9df11addd --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=82c74bd3bc9a11c5833d2010000001e6-1465251632.247339-392662337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-06 15:20:33,107 truncating revision to first 12 chars 2016-06-06 15:20:33,107 Setting DEBUG logging. 2016-06-06 15:20:33,107 attempt 1/10 2016-06-06 15:20:33,107 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f10a5cdcf8a1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-06 15:20:33,410 unpacking tar archive at: fx-team-f10a5cdcf8a1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.630277 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 15:20:33.295383) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 15:20:33.295724) ========= script_repo_revision: f10a5cdcf8a1b908bf2c25f15cc4c8e9df11addd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 15:20:33.296124) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 15:20:33.296414) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 15:20:33.305546) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-06-06 15:20:33.305811) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82c74bd3bc9a11c5833d2010000001e6-1465251632.247339-392662337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:20:33 INFO - MultiFileLogger online at 20160606 15:20:33 in /builds/slave/test 15:20:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 15:20:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:20:33 INFO - {'append_to_log': False, 15:20:33 INFO - 'base_work_dir': '/builds/slave/test', 15:20:33 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:20:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:20:33 INFO - 'branch': 'Fx-Team-Non-PGO', 15:20:33 INFO - 'buildbot_json_path': 'buildprops.json', 15:20:33 INFO - 'config_files': ('talos/linux_config.py',), 15:20:33 INFO - 'default_actions': ('clobber', 15:20:33 INFO - 'read-buildbot-config', 15:20:33 INFO - 'download-and-extract', 15:20:33 INFO - 'populate-webroot', 15:20:33 INFO - 'create-virtualenv', 15:20:33 INFO - 'install', 15:20:33 INFO - 'run-tests'), 15:20:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:20:33 INFO - 'download_minidump_stackwalk': True, 15:20:33 INFO - 'download_symbols': 'ondemand', 15:20:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:20:33 INFO - 'tooltool.py': '/tools/tooltool.py', 15:20:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:20:33 INFO - '/tools/misc-python/virtualenv.py')}, 15:20:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:20:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:20:33 INFO - 'installer_path': 'installer.exe', 15:20:33 INFO - 'log_level': 'info', 15:20:33 INFO - 'log_name': 'talos', 15:20:33 INFO - 'log_to_console': True, 15:20:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:20:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:20:33 INFO - 'opt_config_files': (), 15:20:33 INFO - 'pip_index': False, 15:20:33 INFO - 'sps_profile': False, 15:20:33 INFO - 'sps_profile_interval': 0, 15:20:33 INFO - 'suite': 'dromaeojs-e10s', 15:20:33 INFO - 'system_bits': '32', 15:20:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:20:33 INFO - 'title': 'talos-linux64-ix-066', 15:20:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:20:33 INFO - 'use_talos_json': True, 15:20:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:20:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:20:33 INFO - 'work_dir': 'build'} 15:20:33 INFO - ##### 15:20:33 INFO - ##### Running clobber step. 15:20:33 INFO - ##### 15:20:33 INFO - Running pre-action listener: _resource_record_pre_action 15:20:33 INFO - Running main action method: clobber 15:20:33 INFO - rmtree: /builds/slave/test/build 15:20:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:20:34 INFO - Running post-action listener: _resource_record_post_action 15:20:34 INFO - ##### 15:20:34 INFO - ##### Finished clobber step (success) 15:20:34 INFO - ##### 15:20:34 INFO - ##### 15:20:34 INFO - ##### Running read-buildbot-config step. 15:20:34 INFO - ##### 15:20:34 INFO - Running pre-action listener: _resource_record_pre_action 15:20:34 INFO - Running main action method: read_buildbot_config 15:20:34 INFO - Using buildbot properties: 15:20:34 INFO - { 15:20:34 INFO - "project": "", 15:20:34 INFO - "product": "firefox", 15:20:34 INFO - "script_repo_revision": "production", 15:20:34 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 15:20:34 INFO - "repository": "", 15:20:34 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 15:20:34 INFO - "buildid": "20160606144730", 15:20:34 INFO - "pgo_build": "False", 15:20:34 INFO - "basedir": "/builds/slave/test", 15:20:34 INFO - "buildnumber": 1351, 15:20:34 INFO - "slavename": "talos-linux64-ix-066", 15:20:34 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:20:34 INFO - "platform": "ubuntu64_hw", 15:20:34 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:20:34 INFO - "branch": "fx-team", 15:20:34 INFO - "repo_path": "integration/fx-team", 15:20:34 INFO - "revision": "f10a5cdcf8a1b908bf2c25f15cc4c8e9df11addd", 15:20:34 INFO - "stage_platform": "linux64", 15:20:34 INFO - "builduid": "7d1be82600d0474ea302f641b8808734", 15:20:34 INFO - "slavebuilddir": "test" 15:20:34 INFO - } 15:20:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/Bw3kHOHMQU2wgY-ODj17pQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 15:20:34 INFO - Running post-action listener: _resource_record_post_action 15:20:34 INFO - ##### 15:20:34 INFO - ##### Finished read-buildbot-config step (success) 15:20:34 INFO - ##### 15:20:34 INFO - ##### 15:20:34 INFO - ##### Running download-and-extract step. 15:20:34 INFO - ##### 15:20:34 INFO - Running pre-action listener: _resource_record_pre_action 15:20:34 INFO - Running main action method: download_and_extract 15:20:34 INFO - mkdir: /builds/slave/test/build/tests 15:20:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:20:34 INFO - https://queue.taskcluster.net/v1/task/Bw3kHOHMQU2wgY-ODj17pQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:20:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bw3kHOHMQU2wgY-ODj17pQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:20:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bw3kHOHMQU2wgY-ODj17pQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:20:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bw3kHOHMQU2wgY-ODj17pQ/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 15:20:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bw3kHOHMQU2wgY-ODj17pQ/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 15:20:35 INFO - Downloaded 1361 bytes. 15:20:35 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 15:20:35 INFO - Using the following test package requirements: 15:20:35 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 15:20:35 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:20:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:20:35 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:20:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:20:35 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:20:35 INFO - u'jsshell-linux-x86_64.zip'], 15:20:35 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:20:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:20:35 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 15:20:35 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:20:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:20:35 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:20:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:20:35 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:20:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:20:35 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 15:20:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:20:35 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:20:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:20:35 INFO - https://queue.taskcluster.net/v1/task/Bw3kHOHMQU2wgY-ODj17pQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:20:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bw3kHOHMQU2wgY-ODj17pQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:20:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bw3kHOHMQU2wgY-ODj17pQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:20:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bw3kHOHMQU2wgY-ODj17pQ/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 15:20:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bw3kHOHMQU2wgY-ODj17pQ/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 15:20:36 INFO - Downloaded 22870980 bytes. 15:20:36 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'] 15:20:36 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 15:20:37 INFO - Return code: 0 15:20:37 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 15:20:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:20:37 INFO - https://queue.taskcluster.net/v1/task/Bw3kHOHMQU2wgY-ODj17pQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:20:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bw3kHOHMQU2wgY-ODj17pQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:20:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bw3kHOHMQU2wgY-ODj17pQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 15:20:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bw3kHOHMQU2wgY-ODj17pQ/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 15:20:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bw3kHOHMQU2wgY-ODj17pQ/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 15:20:38 INFO - Downloaded 22870980 bytes. 15:20: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'] 15:20: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 15:20:40 INFO - Return code: 0 15:20:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:20:40 INFO - https://queue.taskcluster.net/v1/task/Bw3kHOHMQU2wgY-ODj17pQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:20:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bw3kHOHMQU2wgY-ODj17pQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 15:20:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bw3kHOHMQU2wgY-ODj17pQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 15:20:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bw3kHOHMQU2wgY-ODj17pQ/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 15:20:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bw3kHOHMQU2wgY-ODj17pQ/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 15:20:41 INFO - Downloaded 10833369 bytes. 15:20:41 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'] 15:20:41 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 15:20:41 INFO - Return code: 0 15:20:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:20:41 INFO - https://queue.taskcluster.net/v1/task/Bw3kHOHMQU2wgY-ODj17pQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:20:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bw3kHOHMQU2wgY-ODj17pQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:20:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bw3kHOHMQU2wgY-ODj17pQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:20:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bw3kHOHMQU2wgY-ODj17pQ/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 15:20:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Bw3kHOHMQU2wgY-ODj17pQ/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 15:20:43 INFO - Downloaded 55202603 bytes. 15:20:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Bw3kHOHMQU2wgY-ODj17pQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:20:43 INFO - mkdir: /builds/slave/test/properties 15:20:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:20:43 INFO - Writing to file /builds/slave/test/properties/build_url 15:20:43 INFO - Contents: 15:20:43 INFO - build_url:https://queue.taskcluster.net/v1/task/Bw3kHOHMQU2wgY-ODj17pQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 15:20:44 INFO - Running post-action listener: _resource_record_post_action 15:20:44 INFO - Running post-action listener: set_extra_try_arguments 15:20:44 INFO - ##### 15:20:44 INFO - ##### Finished download-and-extract step (success) 15:20:44 INFO - ##### 15:20:44 INFO - ##### 15:20:44 INFO - ##### Running populate-webroot step. 15:20:44 INFO - ##### 15:20:44 INFO - Running pre-action listener: _resource_record_pre_action 15:20:44 INFO - Running main action method: populate_webroot 15:20:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:20:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:20:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:20:44 INFO - '--tppagecycles', 15:20:44 INFO - '7'], 15:20:44 INFO - 'tests': ['tsvgm']}}, 15:20:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:20:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:20:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:20:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:20:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:20:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:20:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:20:44 INFO - 'talos_options': ['--disable-e10s'], 15:20:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:20:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:20:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:20:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:20:44 INFO - 'talos_options': ['--disable-e10s'], 15:20:44 INFO - 'tests': ['damp', 'tps']}, 15:20:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:20:44 INFO - 'tests': ['damp', 'tps']}, 15:20:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:20:44 INFO - 'tests': ['dromaeo_dom']}, 15:20:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:20:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:20:44 INFO - 'tests': ['a11yr', 15:20:44 INFO - 'ts_paint', 15:20:44 INFO - 'tpaint', 15:20:44 INFO - 'sessionrestore', 15:20:44 INFO - 'sessionrestore_no_auto_restore', 15:20:44 INFO - 'tabpaint']}, 15:20:44 INFO - 'other-e10s': {'tests': ['a11yr', 15:20:44 INFO - 'ts_paint', 15:20:44 INFO - 'tpaint', 15:20:44 INFO - 'sessionrestore', 15:20:44 INFO - 'sessionrestore_no_auto_restore', 15:20:44 INFO - 'tabpaint']}, 15:20:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:20:44 INFO - 'ts_paint', 15:20:44 INFO - 'tpaint', 15:20:44 INFO - 'sessionrestore', 15:20:44 INFO - 'sessionrestore_no_auto_restore', 15:20:44 INFO - 'tabpaint']}, 15:20:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:20:44 INFO - 'ts_paint', 15:20:44 INFO - 'tpaint', 15:20:44 INFO - 'sessionrestore', 15:20:44 INFO - 'sessionrestore_no_auto_restore', 15:20:44 INFO - 'tabpaint']}, 15:20:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:20:44 INFO - 'tests': ['a11yr', 15:20:44 INFO - 'ts_paint', 15:20:44 INFO - 'tpaint', 15:20:44 INFO - 'sessionrestore', 15:20:44 INFO - 'sessionrestore_no_auto_restore', 15:20:44 INFO - 'tabpaint']}, 15:20:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:20:44 INFO - 'tests': ['a11yr', 15:20:44 INFO - 'ts_paint', 15:20:44 INFO - 'tpaint', 15:20:44 INFO - 'sessionrestore', 15:20:44 INFO - 'sessionrestore_no_auto_restore', 15:20:44 INFO - 'tabpaint']}, 15:20:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:20:44 INFO - 'tests': ['tsvgx', 15:20:44 INFO - 'tsvgr_opacity', 15:20:44 INFO - 'tart', 15:20:44 INFO - 'tscrollx', 15:20:44 INFO - 'cart']}, 15:20:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:20:44 INFO - 'tsvgr_opacity', 15:20:44 INFO - 'tart', 15:20:44 INFO - 'tscrollx', 15:20:44 INFO - 'cart']}, 15:20:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:20:44 INFO - 'talos_options': ['--disable-e10s'], 15:20:44 INFO - 'tests': ['tp5o']}, 15:20:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:20:44 INFO - 'tests': ['tp5o']}, 15:20:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:20:44 INFO - 'talos_options': ['--disable-e10s', 15:20:44 INFO - '--xperf_path', 15:20:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:20:44 INFO - 'tests': ['tp5n']}, 15:20:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:20:44 INFO - 'talos_options': ['--xperf_path', 15:20:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:20:44 INFO - 'tests': ['tp5n']}}, 15:20:44 INFO - 'talos.zip': {'path': '', 15:20:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:20:44 INFO - Running post-action listener: _resource_record_post_action 15:20:44 INFO - ##### 15:20:44 INFO - ##### Finished populate-webroot step (success) 15:20:44 INFO - ##### 15:20:44 INFO - ##### 15:20:44 INFO - ##### Running create-virtualenv step. 15:20:44 INFO - ##### 15:20:44 INFO - Running pre-action listener: _resource_record_pre_action 15:20:44 INFO - Running main action method: create_virtualenv 15:20:44 INFO - Creating virtualenv /builds/slave/test/build/venv 15:20: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 15:20:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:20:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:20:44 INFO - Using real prefix '/usr' 15:20:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:20:45 INFO - Installing distribute.............................................................................................................................................................................................done. 15:20:47 INFO - Installing pip.................done. 15:20:47 INFO - Return code: 0 15:20:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:20: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')]} 15:20:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:20:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20: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')]} 15:20:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:20:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20: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 0x7f6a8f4fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf0f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9e1c0>, '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 0xf9f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9f550>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465251632.247339-392662337', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:20: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 15:20: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 15:20:47 INFO - Using env: {'DISPLAY': ':0', 15:20:47 INFO - 'HOME': '/home/cltbld', 15:20:47 INFO - 'LANG': 'en_US.UTF-8', 15:20:47 INFO - 'LANGUAGE': 'en_US:en', 15:20:47 INFO - 'LOGNAME': 'cltbld', 15:20:47 INFO - 'MAIL': '/var/mail/cltbld', 15:20:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:47 INFO - 'MOZ_NO_REMOTE': '1', 15:20:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:20:47 INFO - 'NO_EM_RESTART': '1', 15:20:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:20:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:47 INFO - 'PWD': '/builds/slave/test', 15:20:47 INFO - 'SHELL': '/bin/bash', 15:20:47 INFO - 'SHLVL': '1', 15:20:47 INFO - 'TERM': 'linux', 15:20:47 INFO - 'TMOUT': '86400', 15:20:47 INFO - 'USER': 'cltbld', 15:20:47 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465251632.247339-392662337', 15:20:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:47 INFO - '_': '/tools/buildbot/bin/python'} 15:20:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:20: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 15:20:47 INFO - Cleaning up... 15:20:47 INFO - Return code: 0 15:20:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:20: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')]} 15:20:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:20:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20: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')]} 15:20:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:20:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20: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 0x7f6a8f4fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf0f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9e1c0>, '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 0xf9f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9f550>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465251632.247339-392662337', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:20: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 15:20: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 15:20:47 INFO - Using env: {'DISPLAY': ':0', 15:20:47 INFO - 'HOME': '/home/cltbld', 15:20:47 INFO - 'LANG': 'en_US.UTF-8', 15:20:47 INFO - 'LANGUAGE': 'en_US:en', 15:20:47 INFO - 'LOGNAME': 'cltbld', 15:20:47 INFO - 'MAIL': '/var/mail/cltbld', 15:20:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:47 INFO - 'MOZ_NO_REMOTE': '1', 15:20:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:20:47 INFO - 'NO_EM_RESTART': '1', 15:20:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:20:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:47 INFO - 'PWD': '/builds/slave/test', 15:20:47 INFO - 'SHELL': '/bin/bash', 15:20:47 INFO - 'SHLVL': '1', 15:20:47 INFO - 'TERM': 'linux', 15:20:47 INFO - 'TMOUT': '86400', 15:20:47 INFO - 'USER': 'cltbld', 15:20:47 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465251632.247339-392662337', 15:20:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:47 INFO - '_': '/tools/buildbot/bin/python'} 15:20:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:20:47 INFO - Downloading/unpacking psutil>=3.1.1 15:20: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 15:20: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 15:20: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 15:20: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 15:20: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 15:20: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 15:20:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:20:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:20:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:20:49 INFO - Installing collected packages: psutil 15:20:49 INFO - Running setup.py install for psutil 15:20:49 INFO - building 'psutil._psutil_linux' extension 15:20:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:20:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:20:50 INFO - building 'psutil._psutil_posix' extension 15:20: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 15:20: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 15:20:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:20:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:20:50 INFO - Successfully installed psutil 15:20:50 INFO - Cleaning up... 15:20:50 INFO - Return code: 0 15:20:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:20: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')]} 15:20:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:20:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20: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')]} 15:20:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:20:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20: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 0x7f6a8f4fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf0f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9e1c0>, '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 0xf9f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9f550>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465251632.247339-392662337', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:20: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 15:20: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 15:20:50 INFO - Using env: {'DISPLAY': ':0', 15:20:50 INFO - 'HOME': '/home/cltbld', 15:20:50 INFO - 'LANG': 'en_US.UTF-8', 15:20:50 INFO - 'LANGUAGE': 'en_US:en', 15:20:50 INFO - 'LOGNAME': 'cltbld', 15:20:50 INFO - 'MAIL': '/var/mail/cltbld', 15:20:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:50 INFO - 'MOZ_NO_REMOTE': '1', 15:20:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:20:50 INFO - 'NO_EM_RESTART': '1', 15:20:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:20:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:50 INFO - 'PWD': '/builds/slave/test', 15:20:50 INFO - 'SHELL': '/bin/bash', 15:20:50 INFO - 'SHLVL': '1', 15:20:50 INFO - 'TERM': 'linux', 15:20:50 INFO - 'TMOUT': '86400', 15:20:50 INFO - 'USER': 'cltbld', 15:20:50 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465251632.247339-392662337', 15:20:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:50 INFO - '_': '/tools/buildbot/bin/python'} 15:20:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:20:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:20:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:20:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:20:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:20:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:20:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:20:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:20:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:20:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:20:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:20:52 INFO - Installing collected packages: mozsystemmonitor 15:20:52 INFO - Running setup.py install for mozsystemmonitor 15:20:52 INFO - Successfully installed mozsystemmonitor 15:20:52 INFO - Cleaning up... 15:20:52 INFO - Return code: 0 15:20:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:20: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')]} 15:20:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:20:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20: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')]} 15:20:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:20:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20: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', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6a8f4fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf0f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9e1c0>, '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 0xf9f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9f550>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465251632.247339-392662337', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:20: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:20: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 jsonschema==2.5.1 15:20:52 INFO - Using env: {'DISPLAY': ':0', 15:20:52 INFO - 'HOME': '/home/cltbld', 15:20:52 INFO - 'LANG': 'en_US.UTF-8', 15:20:52 INFO - 'LANGUAGE': 'en_US:en', 15:20:52 INFO - 'LOGNAME': 'cltbld', 15:20:52 INFO - 'MAIL': '/var/mail/cltbld', 15:20:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:52 INFO - 'MOZ_NO_REMOTE': '1', 15:20:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:20:52 INFO - 'NO_EM_RESTART': '1', 15:20:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:20:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:52 INFO - 'PWD': '/builds/slave/test', 15:20:52 INFO - 'SHELL': '/bin/bash', 15:20:52 INFO - 'SHLVL': '1', 15:20:52 INFO - 'TERM': 'linux', 15:20:52 INFO - 'TMOUT': '86400', 15:20:52 INFO - 'USER': 'cltbld', 15:20:52 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465251632.247339-392662337', 15:20:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:52 INFO - '_': '/tools/buildbot/bin/python'} 15:20:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:20:52 INFO - Downloading/unpacking jsonschema==2.5.1 15:20:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:20:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:20:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:20:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:20:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:20:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:20:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:20:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:20:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:20:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:20:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:20:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:20:55 INFO - Downloading functools32-3.2.3-2.tar.gz 15:20:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:20:55 INFO - warning: no files found matching '*.txt' 15:20:55 INFO - no previously-included directories found matching 'build' 15:20:55 INFO - no previously-included directories found matching 'dist' 15:20:55 INFO - no previously-included directories found matching '.git*' 15:20:55 INFO - Installing collected packages: jsonschema, functools32 15:20:55 INFO - Running setup.py install for functools32 15:20:55 INFO - warning: no files found matching '*.txt' 15:20:55 INFO - no previously-included directories found matching 'build' 15:20:55 INFO - no previously-included directories found matching 'dist' 15:20:55 INFO - no previously-included directories found matching '.git*' 15:20:55 INFO - Successfully installed jsonschema functools32 15:20:55 INFO - Cleaning up... 15:20:55 INFO - Return code: 0 15:20:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:20:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:20:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:20:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:20:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:20:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:55 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 0x7f6a8f4fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf0f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9e1c0>, '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 0xf9f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9f550>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465251632.247339-392662337', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:20:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:20:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:20:55 INFO - Using env: {'DISPLAY': ':0', 15:20:55 INFO - 'HOME': '/home/cltbld', 15:20:55 INFO - 'LANG': 'en_US.UTF-8', 15:20:55 INFO - 'LANGUAGE': 'en_US:en', 15:20:55 INFO - 'LOGNAME': 'cltbld', 15:20:55 INFO - 'MAIL': '/var/mail/cltbld', 15:20:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:55 INFO - 'MOZ_NO_REMOTE': '1', 15:20:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:20:55 INFO - 'NO_EM_RESTART': '1', 15:20:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:20:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:55 INFO - 'PWD': '/builds/slave/test', 15:20:55 INFO - 'SHELL': '/bin/bash', 15:20:55 INFO - 'SHLVL': '1', 15:20:55 INFO - 'TERM': 'linux', 15:20:55 INFO - 'TMOUT': '86400', 15:20:55 INFO - 'USER': 'cltbld', 15:20:55 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465251632.247339-392662337', 15:20:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:55 INFO - '_': '/tools/buildbot/bin/python'} 15:20:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:20:55 INFO - Downloading/unpacking blobuploader==1.2.4 15:20: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 15:20: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 15:20: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 15:20: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 15:20: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 15:20: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 15:20:57 INFO - Downloading blobuploader-1.2.4.tar.gz 15:20:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:20:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:20:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:20:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:20:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:20:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:20:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:20:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:20:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:20:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:20:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:20:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:20:58 INFO - Downloading docopt-0.6.1.tar.gz 15:20:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:20:58 INFO - Installing collected packages: blobuploader, requests, docopt 15:20:58 INFO - Running setup.py install for blobuploader 15:20:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:20:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:20:58 INFO - Running setup.py install for requests 15:20:58 INFO - Running setup.py install for docopt 15:20:58 INFO - Successfully installed blobuploader requests docopt 15:20:58 INFO - Cleaning up... 15:20:58 INFO - Return code: 0 15:20:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:20:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:20:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:20:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:20:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:58 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 0x7f6a8f4fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf0f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9e1c0>, '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 0xf9f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9f550>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465251632.247339-392662337', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:20:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:20:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:20:58 INFO - Using env: {'DISPLAY': ':0', 15:20:58 INFO - 'HOME': '/home/cltbld', 15:20:58 INFO - 'LANG': 'en_US.UTF-8', 15:20:58 INFO - 'LANGUAGE': 'en_US:en', 15:20:58 INFO - 'LOGNAME': 'cltbld', 15:20:58 INFO - 'MAIL': '/var/mail/cltbld', 15:20:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:58 INFO - 'MOZ_NO_REMOTE': '1', 15:20:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:20:58 INFO - 'NO_EM_RESTART': '1', 15:20:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:20:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:58 INFO - 'PWD': '/builds/slave/test', 15:20:58 INFO - 'SHELL': '/bin/bash', 15:20:58 INFO - 'SHLVL': '1', 15:20:58 INFO - 'TERM': 'linux', 15:20:58 INFO - 'TMOUT': '86400', 15:20:58 INFO - 'USER': 'cltbld', 15:20:58 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465251632.247339-392662337', 15:20:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:58 INFO - '_': '/tools/buildbot/bin/python'} 15:20:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:20:59 INFO - Running setup.py (path:/tmp/pip-MDclDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:20:59 INFO - Running setup.py (path:/tmp/pip-Yb7kxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:20:59 INFO - Running setup.py (path:/tmp/pip-u6OdcE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:20:59 INFO - Running setup.py (path:/tmp/pip-4V0OFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:20:59 INFO - Running setup.py (path:/tmp/pip-mKM5LG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:20:59 INFO - Running setup.py (path:/tmp/pip-kGBZ4l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:20:59 INFO - Running setup.py (path:/tmp/pip-0Kcy3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:20:59 INFO - Running setup.py (path:/tmp/pip-FWi1yd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:20:59 INFO - Running setup.py (path:/tmp/pip-h3MxAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:20:59 INFO - Running setup.py (path:/tmp/pip-BbXkpJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:20:59 INFO - Running setup.py (path:/tmp/pip-6S_GHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:20:59 INFO - Running setup.py (path:/tmp/pip-u1ilF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:20:59 INFO - Running setup.py (path:/tmp/pip-qXLUXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:20:59 INFO - Running setup.py (path:/tmp/pip-uOxVAf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:21:00 INFO - Running setup.py (path:/tmp/pip-6s_svS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:21:00 INFO - Running setup.py (path:/tmp/pip-HTffna-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:21:00 INFO - Running setup.py (path:/tmp/pip-YuY4To-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:21:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:21:00 INFO - Running setup.py install for manifestparser 15:21:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:21:00 INFO - Running setup.py install for mozcrash 15:21:00 INFO - Running setup.py install for mozdebug 15:21:00 INFO - Running setup.py install for mozdevice 15:21:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:21:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:21:00 INFO - Running setup.py install for mozfile 15:21:00 INFO - Running setup.py install for mozhttpd 15:21:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:21:00 INFO - Running setup.py install for mozinfo 15:21:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:21:00 INFO - Running setup.py install for mozInstall 15:21:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:21:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:21:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:21:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:21:01 INFO - Running setup.py install for mozleak 15:21:01 INFO - Running setup.py install for mozlog 15:21:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:21:01 INFO - Running setup.py install for moznetwork 15:21:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:21:01 INFO - Running setup.py install for mozprocess 15:21:01 INFO - Running setup.py install for mozprofile 15:21:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:21:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:21:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:21:01 INFO - Running setup.py install for mozrunner 15:21:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:21:01 INFO - Running setup.py install for mozscreenshot 15:21:01 INFO - Running setup.py install for moztest 15:21:01 INFO - Running setup.py install for mozversion 15:21:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:21:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:21:02 INFO - Cleaning up... 15:21:02 INFO - Return code: 0 15:21:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:21:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:21:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:21:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:21:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:21:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:02 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 0x7f6a8f4fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf0f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9e1c0>, '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 0xf9f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9f550>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465251632.247339-392662337', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:21:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:21:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:21:02 INFO - Using env: {'DISPLAY': ':0', 15:21:02 INFO - 'HOME': '/home/cltbld', 15:21:02 INFO - 'LANG': 'en_US.UTF-8', 15:21:02 INFO - 'LANGUAGE': 'en_US:en', 15:21:02 INFO - 'LOGNAME': 'cltbld', 15:21:02 INFO - 'MAIL': '/var/mail/cltbld', 15:21:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:21:02 INFO - 'MOZ_NO_REMOTE': '1', 15:21:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:21:02 INFO - 'NO_EM_RESTART': '1', 15:21:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:21:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:21:02 INFO - 'PWD': '/builds/slave/test', 15:21:02 INFO - 'SHELL': '/bin/bash', 15:21:02 INFO - 'SHLVL': '1', 15:21:02 INFO - 'TERM': 'linux', 15:21:02 INFO - 'TMOUT': '86400', 15:21:02 INFO - 'USER': 'cltbld', 15:21:02 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465251632.247339-392662337', 15:21:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:21:02 INFO - '_': '/tools/buildbot/bin/python'} 15:21:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:21:02 INFO - Running setup.py (path:/tmp/pip-_gIkqj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:21:02 INFO - Running setup.py (path:/tmp/pip-1FPUbo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:21:02 INFO - Running setup.py (path:/tmp/pip-6rlaTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:21:02 INFO - Running setup.py (path:/tmp/pip-5ScFSX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:21:02 INFO - Running setup.py (path:/tmp/pip-4ti3to-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:21:02 INFO - Running setup.py (path:/tmp/pip-EWPGRp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:21:02 INFO - Running setup.py (path:/tmp/pip-aGDnwh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:21:02 INFO - Running setup.py (path:/tmp/pip-4Sm2Vz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:21:02 INFO - Running setup.py (path:/tmp/pip-XW_H2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:21:02 INFO - Running setup.py (path:/tmp/pip-5OHvJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:21:03 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)) 15:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:21:03 INFO - Running setup.py (path:/tmp/pip-nwPiAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:21:03 INFO - Running setup.py (path:/tmp/pip-mcKBfY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:21:03 INFO - Running setup.py (path:/tmp/pip-si5Ntm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:21:03 INFO - Running setup.py (path:/tmp/pip-4ooAKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:21:03 INFO - Running setup.py (path:/tmp/pip-HHIlKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:21:03 INFO - Running setup.py (path:/tmp/pip-rLk3ET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:21:03 INFO - Running setup.py (path:/tmp/pip-bXEj2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:21:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:21: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 15:21: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 15:21: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 15:21: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 15:21: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 15:21: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 15:21:05 INFO - Downloading blessings-1.6.tar.gz 15:21:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:21:05 INFO - Installing collected packages: blessings 15:21:05 INFO - Running setup.py install for blessings 15:21:05 INFO - Successfully installed blessings 15:21:05 INFO - Cleaning up... 15:21:05 INFO - Return code: 0 15:21:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:21:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:21:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:21:05 INFO - Reading from file tmpfile_stdout 15:21:05 INFO - Current package versions: 15:21:05 INFO - argparse == 1.2.1 15:21:05 INFO - blessings == 1.6 15:21:05 INFO - blobuploader == 1.2.4 15:21:05 INFO - docopt == 0.6.1 15:21:05 INFO - functools32 == 3.2.3-2 15:21:05 INFO - jsonschema == 2.5.1 15:21:05 INFO - manifestparser == 1.1 15:21:05 INFO - mozInstall == 1.12 15:21:05 INFO - mozcrash == 0.17 15:21:05 INFO - mozdebug == 0.1 15:21:05 INFO - mozdevice == 0.48 15:21:05 INFO - mozfile == 1.2 15:21:05 INFO - mozhttpd == 0.7 15:21:05 INFO - mozinfo == 0.9 15:21:05 INFO - mozleak == 0.1 15:21:05 INFO - mozlog == 3.2 15:21:05 INFO - moznetwork == 0.27 15:21:05 INFO - mozprocess == 0.22 15:21:05 INFO - mozprofile == 0.28 15:21:05 INFO - mozrunner == 6.11 15:21:05 INFO - mozscreenshot == 0.1 15:21:05 INFO - mozsystemmonitor == 0.3 15:21:05 INFO - moztest == 0.7 15:21:05 INFO - mozversion == 1.4 15:21:05 INFO - psutil == 3.1.1 15:21:05 INFO - requests == 1.2.3 15:21:05 INFO - wsgiref == 0.1.2 15:21:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:21:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:21:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:21:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:21:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:05 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 0x7f6a8f4fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf0f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9e1c0>, '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 0xf9f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9f550>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465251632.247339-392662337', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:21:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:21:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:21:05 INFO - Using env: {'DISPLAY': ':0', 15:21:05 INFO - 'HOME': '/home/cltbld', 15:21:05 INFO - 'LANG': 'en_US.UTF-8', 15:21:05 INFO - 'LANGUAGE': 'en_US:en', 15:21:05 INFO - 'LOGNAME': 'cltbld', 15:21:05 INFO - 'MAIL': '/var/mail/cltbld', 15:21:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:21:05 INFO - 'MOZ_NO_REMOTE': '1', 15:21:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:21:05 INFO - 'NO_EM_RESTART': '1', 15:21:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:21:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:21:05 INFO - 'PWD': '/builds/slave/test', 15:21:05 INFO - 'SHELL': '/bin/bash', 15:21:05 INFO - 'SHLVL': '1', 15:21:05 INFO - 'TERM': 'linux', 15:21:05 INFO - 'TMOUT': '86400', 15:21:05 INFO - 'USER': 'cltbld', 15:21:05 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465251632.247339-392662337', 15:21:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:21:05 INFO - '_': '/tools/buildbot/bin/python'} 15:21:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:21:06 INFO - Cleaning up... 15:21:06 INFO - Return code: 0 15:21:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:21: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')]} 15:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:21:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21: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')]} 15:21:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:21:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6a8f4fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf0f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9e1c0>, '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 0xf9f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9f550>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465251632.247339-392662337', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:21: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', 'jsonschema'] in /builds/slave/test/build 15:21: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 jsonschema 15:21:06 INFO - Using env: {'DISPLAY': ':0', 15:21:06 INFO - 'HOME': '/home/cltbld', 15:21:06 INFO - 'LANG': 'en_US.UTF-8', 15:21:06 INFO - 'LANGUAGE': 'en_US:en', 15:21:06 INFO - 'LOGNAME': 'cltbld', 15:21:06 INFO - 'MAIL': '/var/mail/cltbld', 15:21:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:21:06 INFO - 'MOZ_NO_REMOTE': '1', 15:21:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:21:06 INFO - 'NO_EM_RESTART': '1', 15:21:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:21:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:21:06 INFO - 'PWD': '/builds/slave/test', 15:21:06 INFO - 'SHELL': '/bin/bash', 15:21:06 INFO - 'SHLVL': '1', 15:21:06 INFO - 'TERM': 'linux', 15:21:06 INFO - 'TMOUT': '86400', 15:21:06 INFO - 'USER': 'cltbld', 15:21:06 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465251632.247339-392662337', 15:21:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:21:06 INFO - '_': '/tools/buildbot/bin/python'} 15:21:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:21:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:21:06 INFO - Cleaning up... 15:21:06 INFO - Return code: 0 15:21:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:21: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')]} 15:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:21:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21: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')]} 15:21:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:21:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21: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 0x7f6a8f4fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf0f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9e1c0>, '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 0xf9f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9f550>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465251632.247339-392662337', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:21: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 15:21: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 15:21:06 INFO - Using env: {'DISPLAY': ':0', 15:21:06 INFO - 'HOME': '/home/cltbld', 15:21:06 INFO - 'LANG': 'en_US.UTF-8', 15:21:06 INFO - 'LANGUAGE': 'en_US:en', 15:21:06 INFO - 'LOGNAME': 'cltbld', 15:21:06 INFO - 'MAIL': '/var/mail/cltbld', 15:21:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:21:06 INFO - 'MOZ_NO_REMOTE': '1', 15:21:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:21:06 INFO - 'NO_EM_RESTART': '1', 15:21:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:21:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:21:06 INFO - 'PWD': '/builds/slave/test', 15:21:06 INFO - 'SHELL': '/bin/bash', 15:21:06 INFO - 'SHLVL': '1', 15:21:06 INFO - 'TERM': 'linux', 15:21:06 INFO - 'TMOUT': '86400', 15:21:06 INFO - 'USER': 'cltbld', 15:21:06 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465251632.247339-392662337', 15:21:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:21:06 INFO - '_': '/tools/buildbot/bin/python'} 15:21:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:21:06 INFO - Downloading/unpacking flake8 15:21: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 15:21: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 15:21: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 15:21: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 15:21: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 15:21: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 15:21:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:21:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:21: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 15:21: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 15:21: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 15:21: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 15:21: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 15:21: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 15:21:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:21:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:21: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 15:21: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 15:21: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 15:21: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 15:21: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 15:21: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 15:21:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:21: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 15:21: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 15:21: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 15:21: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 15:21: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 15:21: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 15:21:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:21:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:21:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:21:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:21:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:21:09 INFO - no previously-included directories found matching 'docs/_build' 15:21:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:21:09 INFO - Running setup.py install for pep8 15:21:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:21:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:21:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:21:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:21:09 INFO - no previously-included directories found matching 'docs/_build' 15:21:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:21:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:21:09 INFO - Cleaning up... 15:21:09 INFO - Return code: 0 15:21:09 INFO - Running post-action listener: _resource_record_post_action 15:21:09 INFO - Running post-action listener: _start_resource_monitoring 15:21:09 INFO - Starting resource monitoring. 15:21:09 INFO - ##### 15:21:09 INFO - ##### Finished create-virtualenv step (success) 15:21:09 INFO - ##### 15:21:09 INFO - ##### 15:21:09 INFO - ##### Running install step. 15:21:09 INFO - ##### 15:21:09 INFO - Running pre-action listener: _resource_record_pre_action 15:21:09 INFO - Running main action method: install 15:21:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:21:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:21:09 INFO - Reading from file tmpfile_stdout 15:21:09 INFO - Detecting whether we're running mozinstall >=1.0... 15:21:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:21:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:21:09 INFO - Reading from file tmpfile_stdout 15:21:09 INFO - Output received: 15:21:09 INFO - Usage: mozinstall [options] installer 15:21:09 INFO - Options: 15:21:09 INFO - -h, --help show this help message and exit 15:21:09 INFO - -d DEST, --destination=DEST 15:21:09 INFO - Directory to install application into. [default: 15:21:09 INFO - "/builds/slave/test"] 15:21:09 INFO - --app=APP Application being installed. [default: firefox] 15:21:09 INFO - mkdir: /builds/slave/test/build/application 15:21: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'] 15:21: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 15:21:25 INFO - Reading from file tmpfile_stdout 15:21:25 INFO - Output received: 15:21:25 INFO - /builds/slave/test/build/application/firefox/firefox 15:21:25 INFO - Running post-action listener: _resource_record_post_action 15:21:25 INFO - ##### 15:21:25 INFO - ##### Finished install step (success) 15:21:25 INFO - ##### 15:21:25 INFO - ##### 15:21:25 INFO - ##### Running run-tests step. 15:21:25 INFO - ##### 15:21:25 INFO - Running pre-action listener: _resource_record_pre_action 15:21:25 INFO - Running main action method: run_tests 15:21:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:21:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:21:25 INFO - Python 2.7.3 15:21:25 INFO - Return code: 0 15:21:25 INFO - grabbing minidump binary from tooltool 15:21:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:21:25 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 0xf9e1c0>, '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 0xf9f0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9f550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:21:25 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 15:21:25 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 15:21:25 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 15:21:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:21:25 INFO - Return code: 0 15:21:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:21:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:21:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:21:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:21:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:21:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:21:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:21:26 INFO - Return code: 0 15:21:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Bw3kHOHMQU2wgY-ODj17pQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:21:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Bw3kHOHMQU2wgY-ODj17pQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:21:26 INFO - Using env: {'DISPLAY': ':0', 15:21:26 INFO - 'HOME': '/home/cltbld', 15:21:26 INFO - 'LANG': 'en_US.UTF-8', 15:21:26 INFO - 'LANGUAGE': 'en_US:en', 15:21:26 INFO - 'LOGNAME': 'cltbld', 15:21:26 INFO - 'MAIL': '/var/mail/cltbld', 15:21:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:21:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:21:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:21:26 INFO - 'MOZ_NO_REMOTE': '1', 15:21:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:21:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:21:26 INFO - 'NO_EM_RESTART': '1', 15:21:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:21:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:21:26 INFO - 'PWD': '/builds/slave/test', 15:21:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:21:26 INFO - 'SHELL': '/bin/bash', 15:21:26 INFO - 'SHLVL': '1', 15:21:26 INFO - 'TERM': 'linux', 15:21:26 INFO - 'TMOUT': '86400', 15:21:26 INFO - 'USER': 'cltbld', 15:21:26 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465251632.247339-392662337', 15:21:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:21:26 INFO - '_': '/tools/buildbot/bin/python'} 15:21:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Bw3kHOHMQU2wgY-ODj17pQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:21:26 INFO - mozversion application_buildid: 20160606144730 15:21:26 INFO - mozversion application_changeset: f10a5cdcf8a1b908bf2c25f15cc4c8e9df11addd 15:21:26 INFO - mozversion application_display_name: Nightly 15:21:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:21:26 INFO - mozversion application_name: Firefox 15:21:26 INFO - mozversion application_remotingname: firefox 15:21:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:21:26 INFO - mozversion application_vendor: Mozilla 15:21:26 INFO - mozversion application_version: 49.0a1 15:21:26 INFO - mozversion platform_buildid: 20160606144730 15:21:26 INFO - mozversion platform_changeset: f10a5cdcf8a1b908bf2c25f15cc4c8e9df11addd 15:21:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:21:26 INFO - mozversion platform_version: 49.0a1 15:21:26 INFO - using testdate: 1465251686 15:21:26 INFO - actual date: 1465251686 15:21:26 INFO - starting webserver on 'localhost:59617' 15:21:26 INFO - SUITE-START | Running 2 tests 15:21:26 INFO - TEST-START | dromaeo_css 15:21:26 INFO - operating with platform_type : linux_ 15:21:26 INFO - Initialising browser for dromaeo_css test... 15:21:26 INFO - TEST-INFO | started process 12294 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI_H3ho/profile http://localhost:59617/getInfo.html) 15:21:32 INFO - PROCESS | 12294 | __metrics Screen width/height:1600/1200 15:21:32 INFO - PROCESS | 12294 | colorDepth:24 15:21:32 INFO - PROCESS | 12294 | Browser inner width/height: 1024/697 15:21:32 INFO - PROCESS | 12294 | __metrics 15:21:32 ERROR - PROCESS | 12294 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2944: TypeError: this.tabs is undefined 15:21:33 INFO - TEST-INFO | 12294: exit 0 15:21:33 INFO - Browser initialized. 15:21:33 INFO - Running cycle 1/1 for dromaeo_css test... 15:21:33 INFO - TEST-INFO | started process 12413 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI_H3ho/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:21:45 INFO - PROCESS | 12413 | RSS: Main: 168378368 15:21:45 INFO - PROCESS | 12413 | 15:22:35 INFO - PROCESS | 12413 | 1465251755362 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] 15:24:46 INFO - PROCESS | 12413 | Cycle 1(1): loaded http://localhost:59617/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59617/tests/dromaeo/cssquery-ext.html) 15:24:47 INFO - PROCESS | 12413 | RSS: Main: 171642880 15:24:47 INFO - PROCESS | 12413 | 15:27:50 INFO - PROCESS | 12413 | Cycle 1(1): loaded http://localhost:59617/tests/dromaeo/cssquery-ext.html (next: http://localhost:59617/tests/dromaeo/cssquery-jquery.html) 15:27:50 INFO - PROCESS | 12413 | RSS: Main: 170500096 15:27:50 INFO - PROCESS | 12413 | 15:30:52 INFO - PROCESS | 12413 | Cycle 1(1): loaded http://localhost:59617/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59617/tests/dromaeo/cssquery-mootools.html) 15:30:53 INFO - PROCESS | 12413 | RSS: Main: 172097536 15:30:53 INFO - PROCESS | 12413 | 15:33:55 INFO - PROCESS | 12413 | Cycle 1(1): loaded http://localhost:59617/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59617/tests/dromaeo/cssquery-prototype.html) 15:33:55 INFO - PROCESS | 12413 | RSS: Main: 169271296 15:33:55 INFO - PROCESS | 12413 | 15:36:58 INFO - PROCESS | 12413 | Cycle 1(1): loaded http://localhost:59617/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59617/tests/dromaeo/cssquery-yui.html) 15:36:59 INFO - PROCESS | 12413 | RSS: Main: 171597824 15:36:59 INFO - PROCESS | 12413 | 15:40:01 INFO - PROCESS | 12413 | Cycle 1(1): loaded http://localhost:59617/tests/dromaeo/cssquery-yui.html (next: http://localhost:59617/tests/dromaeo/cssquery-dojo.html) 15:40:01 INFO - PROCESS | 12413 | RSS: Main: 172593152 15:40:01 INFO - PROCESS | 12413 | 15:40:01 INFO - PROCESS | 12413 | __start_tp_report 15:40:01 INFO - PROCESS | 12413 | _x_x_mozilla_page_load 15:40:01 INFO - PROCESS | 12413 | _x_x_mozilla_page_load_details 15:40:01 INFO - PROCESS | 12413 | |i|pagename|runs| 15:40:01 INFO - PROCESS | 12413 | |0;dojo.html;2687.0998215597774;2687.4759421912727;2722.33302840804;2730.5085084684747;2732.740389662981;4643.674942754009;4715.575598196162;4760.309755085519;4764;4791.329213910051;4643.651726120537;4777.307290442893;4777.665563410554;4808.639352048593;4813.687110337834;4342.044750154961;4377.78111094444;4462.709923854955;4476.060027394235;4480.843170489034;4173.770442625654;4466.039801442689;4495.730256184623;4504.617107545862;4521.457425108992;4336.631386332166;4364.956350436487;4397.670174736908;4406.294992801137;4475.239209334389;4349.586789255016;4352.36890650857;4358.585934336233;4359.215341238576;4397.098594788061;4363.80362883671;4367.410399596046;4375.431193944799;4385.846495372647;4402.207602631525;4667.533246675339;4720.362751028636;4729.219678753002;4742;4748.5014073522125;5168.2764412982215;5175;5190.195519694454;5209.453007434203;5214.661047031968;5050.823221187241;5185.55922746567;5209.1665333546825;5222.582193424517;5225.085610018232;4800.087983283165;4861.611071114302;4877.707337559757;4903.068417000758;4923.556879880756;5298.735063246822;5324.923642323214;5353.250544923714;5361.839144825662;5389.27244821944;4895.657303988686;4942.258661200849;5073.797048118107;5099.847004589868;5139.152039913447;5096.235564665256;5120.155174396183;5143.4085080216255;5146.588272938156;5198.610104242197;4935.185694360463;5083.593312534988;5102;5115.846524604193;5132.050570644443;4894.951050489521;5049.31834202378;5088.542031217208;5100.209467532539;5168.224766285088;4263.4031235627035;4271.487421509377;4287.3783301421745;4293.162833247487;4324.632406245441;3704.0554658561896;3717.3308804414924;3762.4732537444233;3801.6198380161763;3824.1778017726324;4428.579284967923;4456.064226512404;4461.754603496774;4466.642668586505;4494.685372023992;5151.896962060738;5171.922421163686;5184.015037142931;5190.792368305301;5268.420473747885;4502.347159661831;4506.504284528699;4529.456465224194;4535;4578.381918440968;4493.910121797611;4593.839215627437;4620.237660786;4631.907361852812;4653.302004699254;4901.975490122598;4915.705057696549;4935.975320123376;4946.406431228275;4977.950220497749;5189.974050129726;5223.164293712987;5224.791008359775;5232.215167724872;5238.319018527567;4869.756512174448;4909.95090049095;4926.7929357307685;4937.851864444073;4948.480409557089;5156.303898973591;5170.586353091669;5172.19830926207;5185.092608793521;5218.66078704883;5015.648904576645;5173.896522069613;5241.764120614658;5245.055889939695;5252.894942101213;4792.137415265146;4917.385326834145;5043.697378157322;5052.216906379517;5088.313077734459;4981.501849814989;4998.500149984972;5004.649674522749;5010.649254552292;5018.071656743514;4759.0719809636785;4828.985912958318;4861.1006963711825;4866.051120031701;4945.307656927961;5034.043531728959;5052.494750525065;5074.391073071255;5102.770375333193;5133.845984620468;4926.729029903389;4968.105740966516;4975.427825799935;4978.850634480971;5025.874353141201 15:40:01 INFO - PROCESS | 12413 | |1;ext.html;553.6097051578638;592.7954855574827;602.8432607522043;606.9105954811114;621.0683974038942;39472;41610.167796644084;41649.167016659645;41856.16287674245;44531;39188.80405597975;39528.60471395285;39612;39751;40025.199496010064;7596.240375962415;7725.922740772605;7727.768166954972;7733.651985660659;7748.845023099535;7653.502522336031;7662.003939487887;7704.114026886924;7712.421568382366;7721.343685786715;7682.270184332508;7688.34649054831;7703.383729301642;7719.922800771977;7734.226577342249;7674.117476490219;7696.923030769676;7716.498427602188;7722.691092356271;7744.148143704188;7618.200088990631;7708.152103268636;7709.151993280735;7745.1867553906595;7763.961180194119;36005.81997090024;36248;36472.541098356036;36533.45199822005;36637.81681091604;3089.3821235752716;3090.3355778507503;3136.6549679535233;3165.018844158318;3377.9662203378143;25799.87100064488;27239.45521089587;27946.860265698542;27961.720382796117;28025.57961630577;3316.7512436567113;3320.8505617247283;3322.933541329184;3333.4333163362285;3345.7156141727983;210907;211480;211967;213298;213323.80085792197;28351.57472637912;29031.27421814429;50684;50864;50965.49034509608;33737;33806.49290260599;33827.4925876112;34004.1498962523;34061.659383406346;11993;12129.241260017248;12144.878551214375;12149.392530373623;12161.878381216251;10509.106725928228;10640.627578034731;10641.467926603638;10646.680599582025;10658.840117398246;7899.210078992055;7950.840983180304;7953.403494737918;8031.919680803234;8057.959710201529;3095.4273459410083;3109.6112985876766;3143.339898621269;3153.3220357623222;3179.2846609513135;878.0955615715823;907.8002839375326;987.5457289646699;1025.2464438637596;1047.1151876664208;28165.43669126606;28516.857415712788;28588.28529286743;28898.277543061173;29017.12948611545;928.7167413938679;966.463612694947;968.8298212005058;1051.9421431821324;1053.3995622495104;14904.701905962036;15053.924730376279;15181.316840742193;15244.771328430083;15311.846881531264;396300.07399852417;397610;400727;401844;402102;49330.340404045;49523.752381237864;49774;49848.50151498511;50086.74956625266;1214.2228973456995;1217.713837248246;1219.0552321950381;1220.7558488302375;1244.402686710366;26853.731462685904;27837;28143.296417589725;28157.859210703817;28450.146495605164;42459;42570.57429425666;42855.57144428516;42921.785391072845;43070.56929430665;280330;280842;340662;343135;343207;25097.49805003853;25284.367890802878;25505;25652.871735641947;26591.468170636865;42024.36963445612;42362.788186060105;42505.36241956435;42660.1467970645;42956.57043429526;35783.46324805182;35827.82086089657;36105.27789444144;36252.456213157355;36549.81725091358;35434.29131417409;35925.82037089798;35948.28103437864;35952.64047359493;36308.636913631584;35416.29167416689;35711.46432803458;36080.09799755027;36182.27635447224;36520.81739591285;31234.68765312409;33008.1747956303;33034.339313214085;33270.334593308486;33369;24823;24928.626070608592;25422.74577254204;25737;25861.224163275132 15:40:01 INFO - PROCESS | 12413 | |2;jquery.html;345.7355123330651;353.98938031859046;354.7516738283202;358.73991356266725;370.6478845097158;15680.764788528168;16233.512994610166;17358.56603584908;17359.132043397825;17390.652186956253;16014.19929003551;16382.576704289864;16936.661266774656;16957.067361295125;17037.7444338335;4900.166971614816;5096.8470945871495;5128.846134615949;5131.358580177478;5144;3648.343298206322;5045.596352291808;5623.8594035149035;5920.082387229964;5931.4068593140555;5946.791862284821;5972.343042265347;5998.310194327664;6003.8198854034445;6013.879722405549;5685.118806584986;5809.099589563624;5832.591718579701;5853.180554722342;5860.501857342131;4381.145676593065;5083.949160508385;5087;5102.132637451605;5126.256692779563;10823.29648572848;11348.489317980711;11366.943165284121;11379.089672826154;11382.089432845352;1823.8358547730768;1843.2626949220285;1914.6840771272862;1932.80671932807;1973.4671638657626;8104.756857294232;8525.44584601999;8573.356998225096;8639.52482613456;8712.433691810013;1653.264297387663;1714.9056801875893;1741.912904354777;1752.9211185496556;1756.6925787987052;64539;66050.66974665096;66192.33807661958;66714;67127;9222.44665320083;9524.714163587965;9627.277954153467;9635.470049147365;9661.420314781135;13075.542356017493;13164.210147391188;13194.604161875159;13209.273489958145;13229.470821167239;6781.525293229427;6933.653317334214;7002.684879180449;7073.61095139762;7352.522086064496;6149.877002459926;6275.560710750295;6448.838779030468;6461.386168314003;6470.479437332223;3941.3693808990997;4008.2985477541315;4020.0753826619457;4112.485939257593;4207.431996680471;1587.857092861648;1699.8640108791267;1742.9128543573024;1805.6840052990674;1839.8712090153829;828.2876726015621;886.5035580075049;888.4624801994829;895.4448242089946;992.3648864726581;15817.604559886095;15906.681866362607;16144;16151.757723634155;16656.16719164037;876.5135349880877;889.8264838356458;908.6774195160623;951.7906060666643;974.6637410093506;9255.167034966751;9297.628094876265;9346.392484488486;9353.296338952328;9357.812843743088;375592;377128;386930;391832;392714;58768.70615646894;71192.64403677949;72632.63683681653;72726.27273727302;75203;855.9144085591391;894.3605322194662;939.9060093990684;942.6417961174847;945.2626950978248;15488.380464781283;15532.61168470752;15560.688786223986;15886.126263055643;16050.839491604935;35431.468527971585;36909;37291.81354093212;37807;37915.62084379121;47242.52757472519;51527.74236128795;51569.48430515797;51768;52114;7180.497365184387;7254.347108760237;7365.600535898377;7371.447141464519;7628.313451789366;10214.846777298199;11498.712532186762;11813.940930295637;11885.82171267449;12150.453229604513;10143.88417274114;10242.948785256027;10365.222608304559;10470.424126673106;10486.265961382935;4411.1618792429335;8436.409451338348;9609.327347085917;10336.896631033593;10629;10316.76198856142;10488.580456781949;10502.212334074822;10676;10695.89304106949;7201.423886089205;7398.371138453292;7399.963000184965;7493.400527957641;7598.848023039398;9923.55344009507;9957.601695932082;10087.495625218562;10214.233932454947;10346 15:40:01 INFO - PROCESS | 12413 | |3;mootools.html;1399.4052527675738;1437.1592618318284;1563.2652653252967;1742.3030787684916;1755.8419742223198;7006.579605223677;7350.154732205798;7656.502327348725;8238.794030149249;8239.176082391758;7528.84942301155;7703.3452156566755;7818.335441487467;7819.452638315321;7832.334251588622;2156.956860862778;2227.721534808149;2227.888605569723;2229.0972156276734;2231.497912969577;2166.5125346797004;2183.5632873425297;2192.1888901106613;2192.7697591752876;2198.1976578548793;2167.5773224221284;2169.967450488244;2177.5318306564086;2181.4219231903558;2227.587896239193;2092;2096.6540520814124;2104.863183893042;2112.7781582933876;2113.2814842953317;2110.2930518276394;2128.606207851537;2133.5839511295303;2142.78572142786;2142.817860481861;7733.226677332278;7774.494657847222;7782.766517004499;7824.765257042298;7833.882491762628;4470.75410852403;4538.659600529973;4566.954330456686;4577.8397756078375;4602.240630295997;2850.957235641467;2881.063654312357;2964.762818974477;2981.344104297051;2990.3421247325555;824.1675907333636;854.03920589337;862.1464749897619;864.6627815152095;869.6173683579204;10529.526171322308;10562.20783441245;10567.78864422715;10593.523291451826;10656.360618362924;4186.958130418718;4239.766812825324;4309.48286205651;4315.115401342718;4345.826166953287;8954.597043133075;8962.955185224033;9030.36787424887;9047.095290471032;9048.41185322952;4475.351074094238;4483.775811209492;4539.886502837389;4542.409486766699;4553.248713962159;3704.0554658561896;4063.959360406417;4138.275801734684;4149.502059752849;4233.555476674905;3575.94636080459;3606.2246616977477;3663.9267214656093;3677.2277821657754;3700.4634328022826;1203.18784820246;1211.8242854786006;1217.3669691760413;1236.511577926714;1238.8327575777334;796.3708670150517;889.208604342136;894.9284057275403;902.9593668284812;926.282131348197;5448.291722076105;5524.944750552443;5571.526420254243;5625.803096891589;5745.569082318842;927.3091546797679;939.2110627073291;974.1281553010158;988.2538683294067;1005.582683186484;3814.7520411173186;3937.527496700357;3953.8220780064967;3979.621935916083;3993.480847489866;9503.19222866064;9710.805783884283;9799.167070799062;9853.605855765833;9865.309428339948;9695;9823.705288841345;9847.704568862946;9847.852282215772;9858.753531161636;7087.433005359559;7344.559326440431;7423.740169094164;7459.030326057577;7548.698052077855;5686.203931449683;5834.533237341087;5864.67744274069;5944.078667806497;6002.459778619946;8809.911900881165;9035.096490350912;9242.445453272825;9304.023077577027;9329.953350233205;9158.725238242863;9330.673426430314;9337.953310233677;9358.344915855825;9381.343305968516;6064.727087280995;6553.4101930826455;6719.764808231688;6994.160700715946;7159.749408770668;7682.500637458547;7750.379969602305;7797.181295963842;7806.219378062148;7810.179931107379;6720;6882.277360877236;6906.06768086322;7007.859842803014;7242;6726.159230096238;6733.461323094043;6770.255271920183;6783.3555812197765;6877.552959057645;6050.969745151246;6258.311585725475;6667.399934005963;6668.166479190101;6712.765053223114;4867.269909513601;4868.2210846264425;4883.975580122076;4927.347474436142;4988.850334489971;4606.654500912378;4656.208444564364;4673.532646735299;4750.07373562152;4751.216049351819 15:40:01 INFO - PROCESS | 12413 | |4;prototype.html;289.6393989483094;292.27515760912934;294.4787725725465;298.0833935647883;298.9715976982186;4969.6521243512925;5028.270900719398;5033.219850923104;5034.320366750488;5036.118679231138;4953.083679519292;4960.751962401883;4964.156093464111;4971.254311853215;4979.751012449381;3657.1954170082604;3730.7388482806214;3801.2017476329866;3824.445455408964;3834.482344883433;3824.2542704172697;3883.76697398157;3892.2215556888596;3914.3149948758996;3915.1386694927214;3899.6490315871565;3900.010994392852;3902.2585708715396;3908.687305015606;3928.9803550982206;3789.166383395676;3796.9430458543143;3859.7841679870753;3868.6711629511524;3921.8431262749455;3347.1130150510135;3371.9494207586904;3374.257663314067;3387.4580067189377;3393.8472768725464;4733.502982186856;4761.619250332268;4792.544708252711;4803.231482962709;4805.351277577517;4375.190589740908;4404.427424434835;4415.227335216325;4417.160739459525;4445.6660253367245;4990.525900039491;5189.714565698885;5192.844214673566;5199.376074871039;5216.58267338612;3718.219173973469;3722.032271609401;3724.6647801697704;3732.850685972558;3733.4959780429567;5462.535684466825;5492.835214943558;5507.284053073115;5523.342997100894;5549.306336707911;3575.66031227033;3827.6172382762056;3833.2333533293454;3843.9807800960816;3848.749831260959;3869.903252418712;3880.6701430378735;3888.2612303662213;3890.6498415142773;3897.3569361055675;4387.310885309179;4406.471223453142;4417.580329868657;4428.623566996777;4436.800343984529;4983.875403114878;5194.792208311701;5238.5023422774775;5255.973720131375;5262.2632831403635;1314.4676406055562;1319.5975227555496;1322.9470821167238;1324.1326930860303;1324.265032906746;848.2483671218913;854.8033952191031;869.3740506835069;871.1549796697194;871.9869201961976;4561.612262957619;4630.490646028934;4650.302454631832;4666.296801667367;4670.602998745077;5400.891982160335;5410.83767486976;5418.810341638024;5419.160030195326;5433.320834895638;4416.933745993749;4613.2388155953895;4657.5575320344515;4667.6732628716345;4689.179393606105;2853.4150499147627;2884.8990285339914;2889.624348834638;2892.421515696869;2899.855007249629;5129.64092513528;5130.461301563282;5136.613114459075;5144.202648589475;5151.5878729701535;5238.711870847063;5506.384467377963;5508.944910550923;5541.806036788693;5574.554035677217;5051.055343692705;5115.923261151086;5127.230915362726;5134.5378915897745;5155.432902380735;5439.374471935778;5454.427285135003;5456.563474921917;5461.262729531462;5468.972655136698;5233.241180028951;5348.839534813962;5352.223927530564;5354.3574771027725;5359.464053594609;5124.3602047345985;5130.384353877558;5140.56305214061;5148.2020286855595;5157.974210128926;3740.2893450244364;3742.5883152853708;3756.830942607644;3778.24435112984;3781.829817658157;5252.867247788667;5416.37711663148;5435.945640543544;5445.128779395278;5479.53423958968;5281.841544753664;5322.520973112439;5336.0661884170895;5336.386315573759;5337.653052551572;5261.973690131525;5287.603429742861;5322.068637988259;5325.600579956441;5333.813316533902;4990.625703072212;5098.847034588968;5169.870753231199;5215.400228973716;5220.295260139833;5006.173981293192;5103.413107492686;5235.397929238034;5291;5293.550048245788;5101.183810590288;5111.821086261963;5125.461826508163;5145.716985565829;5156.020356132323 15:40:01 INFO - PROCESS | 12413 | |5;yui.html;650.3951325267501;674.8076798112539;737.3732327521604;737.8561180569791;759.4380158682575;11877.227980181293;12681.556145534909;12684.175528590635;12819.102662813595;12894.097413181082;12697.492100316;12933.224006559589;12938.870611293883;12946.35268236589;12946.870531294684;626.1984659635651;778.1168373895626;795.0459448661601;796.3549524884833;797.7088362747613;769.6613490064353;795.6896810244009;797.2107613462688;801.1947992267762;801.3789313282194;810.5015415519472;813.6989313953845;820.3888103363003;822.4489591973393;822.6051495282268;807.5397023696495;808.4017826808149;808.8786681997689;813.9918600813975;814.9062857771373;592.1236569876563;592.6799528254737;594.6551000419746;595.2678205806882;595.487880422836;12314.876851231462;12383.133180677356;12410.75178496425;12429.564965226264;12429.937850310691;12894.161879477897;13290.3354832258;13326.733465330639;13357;13518.59444216675;10446.895531044669;10566.577336906514;10636.149108071335;10809.513571889283;10813.567457301699;3336.9481947249537;3358.5465962095295;3388.0682812226587;3398.2863598644312;3414.9146271343166;56214;56352.43647563513;56471.15293270604;56970.715146424416;57041;10491.16070714341;10731.463426828628;10786.999999999844;10840.674779756462;10952.726181845359;16737.07946062954;17566.385176519016;19249.51876203106;19267.51831204203;19334.033298335307;7092.113485814273;7180.1742799578715;7234.312740289664;7280.708771649075;7283.8543229136185;3742.9812850935573;3853.807309634507;3928.46965659638;3934.390169523728;3978.8010599469912;2898.478273910674;3026.7124623160767;3027.9394412111633;3030.3636236390166;3030.848457577112;548.410458756838;548.6872482684911;556.4379976224043;558.4052983572483;565.4543365652083;587.6297932302707;620;621.6208113051035;633.2306247908721;633.9397757213058;8344.499330040217;8805.16350946659;8842.602082906285;9048.819023619622;9272.443653380818;623.863268306059;632.8702615963716;655.5738769799668;658.2747425657781;669.437672355224;3863.768173909574;3982.143839074613;3994.141259629194;4005.118873847749;4221.303484924953;54434.45565544294;54903;55032.17451738227;67790;88766;51181.7440912793;55556.44443555594;75319.62340188264;77762;80575;56100.71949640226;70743.2925670747;70755;70783.64608177029;71618.28381716117;7999;8074.192580741878;8117.472364296538;8188.344932405513;8255;42190;43215.35176972411;43494.78252608717;43766.56233437625;44487.77756111199;52062.73968630133;52410;54119.729401354314;59186.40813591809;60813.69593152006;10497.004472196524;11159.442027898735;11475.311481311148;11661.300321980709;11725.35510546894;12288.201266917979;12531.248125112523;12854.228746275254;12901.806472902726;12969.41637626328;11562.76874462523;11861.822072668745;12053.879461205275;12118.272903625812;12224.388780561114;11384.829227561428;11392.544298227978;11630.302181869114;11911.583094591648;12013.819792702941;11422.543098276308;11464.656060318204;11519;11684;11840.585579504675;9415.952920235355;9516;9521;9813.165880900204;9936.850947235942;9948.502574871372;10073.345232559861;10136.138428233387;10145.239107066853;10163.542640581043 15:40:01 INFO - PROCESS | 12413 | __end_tp_report 15:40:01 INFO - PROCESS | 12413 | __start_cc_report 15:40:01 INFO - PROCESS | 12413 | _x_x_mozilla_cycle_collect,386 15:40:01 INFO - PROCESS | 12413 | __end_cc_report 15:40:01 INFO - PROCESS | 12413 | __startTimestamp1465252801935__endTimestamp 15:40:01 INFO - PROCESS | 12413 | 15:40:01 INFO - PROCESS | 12413 | ------- Summary: start ------- 15:40:01 INFO - PROCESS | 12413 | Number of tests: 6 15:40:01 INFO - PROCESS | 12413 | 15:40:01 INFO - PROCESS | 12413 | [#0] dojo.html Cycles:165 Average:4757.26 Median:4903.07 stddev:510.15 (10.4%) stddev-sans-first:485.18 15:40:01 INFO - PROCESS | 12413 | Values: 2687.1 2687.5 2722.3 2730.5 2732.7 4643.7 4715.6 4760.3 4764.0 4791.3 4643.7 4777.3 4777.7 4808.6 4813.7 4342.0 4377.8 4462.7 4476.1 4480.8 4173.8 4466.0 4495.7 4504.6 4521.5 4336.6 4365.0 4397.7 4406.3 4475.2 4349.6 4352.4 4358.6 4359.2 4397.1 4363.8 4367.4 4375.4 4385.8 4402.2 4667.5 4720.4 4729.2 4742.0 4748.5 5168.3 5175.0 5190.2 5209.5 5214.7 5050.8 5185.6 5209.2 5222.6 5225.1 4800.1 4861.6 4877.7 4903.1 4923.6 5298.7 5324.9 5353.3 5361.8 5389.3 4895.7 4942.3 5073.8 5099.8 5139.2 5096.2 5120.2 5143.4 5146.6 5198.6 4935.2 5083.6 5102.0 5115.8 5132.1 4895.0 5049.3 5088.5 5100.2 5168.2 4263.4 4271.5 4287.4 4293.2 4324.6 3704.1 3717.3 3762.5 3801.6 3824.2 4428.6 4456.1 4461.8 4466.6 4494.7 5151.9 5171.9 5184.0 5190.8 5268.4 4502.3 4506.5 4529.5 4535.0 4578.4 4493.9 4593.8 4620.2 4631.9 4653.3 4902.0 4915.7 4936.0 4946.4 4978.0 5190.0 5223.2 5224.8 5232.2 5238.3 4869.8 4910.0 4926.8 4937.9 4948.5 5156.3 5170.6 5172.2 5185.1 5218.7 5015.6 5173.9 5241.8 5245.1 5252.9 4792.1 4917.4 5043.7 5052.2 5088.3 4981.5 4998.5 5004.6 5010.6 5018.1 4759.1 4829.0 4861.1 4866.1 4945.3 5034.0 5052.5 5074.4 5102.8 5133.8 4926.7 4968.1 4975.4 4978.9 5025.9 15:40:01 INFO - PROCESS | 12413 | 15:40:01 INFO - PROCESS | 12413 | [#1] ext.html Cycles:180 Average:45325.15 Median:35876.82 stddev:84552.03 (235.7%) stddev-sans-first:84722.40 15:40:01 INFO - PROCESS | 12413 | Values: 553.6 592.8 602.8 606.9 621.1 39472.0 41610.2 41649.2 41856.2 44531.0 39188.8 39528.6 39612.0 39751.0 40025.2 7596.2 7725.9 7727.8 7733.7 7748.8 7653.5 7662.0 7704.1 7712.4 7721.3 7682.3 7688.3 7703.4 7719.9 7734.2 7674.1 7696.9 7716.5 7722.7 7744.1 7618.2 7708.2 7709.2 7745.2 7764.0 36005.8 36248.0 36472.5 36533.5 36637.8 3089.4 3090.3 3136.7 3165.0 3378.0 25799.9 27239.5 27946.9 27961.7 28025.6 3316.8 3320.9 3322.9 3333.4 3345.7 210907.0 211480.0 211967.0 213298.0 213323.8 28351.6 29031.3 50684.0 50864.0 50965.5 33737.0 33806.5 33827.5 34004.1 34061.7 11993.0 12129.2 12144.9 12149.4 12161.9 10509.1 10640.6 10641.5 10646.7 10658.8 7899.2 7950.8 7953.4 8031.9 8058.0 3095.4 3109.6 3143.3 3153.3 3179.3 878.1 907.8 987.5 1025.2 1047.1 28165.4 28516.9 28588.3 28898.3 29017.1 928.7 966.5 968.8 1051.9 1053.4 14904.7 15053.9 15181.3 15244.8 15311.8 396300.1 397610.0 400727.0 401844.0 402102.0 49330.3 49523.8 49774.0 49848.5 50086.7 1214.2 1217.7 1219.1 1220.8 1244.4 26853.7 27837.0 28143.3 28157.9 28450.1 42459.0 42570.6 42855.6 42921.8 43070.6 280330.0 280842.0 340662.0 343135.0 343207.0 25097.5 25284.4 25505.0 25652.9 26591.5 42024.4 42362.8 42505.4 42660.1 42956.6 35783.5 35827.8 36105.3 36252.5 36549.8 35434.3 35925.8 35948.3 35952.6 36308.6 35416.3 35711.5 36080.1 36182.3 36520.8 31234.7 33008.2 33034.3 33270.3 33369.0 24823.0 24928.6 25422.7 25737.0 25861.2 15:40:01 INFO - PROCESS | 12413 | 15:40:01 INFO - PROCESS | 12413 | [#2] jquery.html Cycles:180 Average:23472.64 Median:5064.77 stddev:63451.05 (1252.8%) stddev-sans-first:63605.28 15:40:01 INFO - PROCESS | 12413 | Values: 345.7 354.0 354.8 358.7 370.6 15680.8 16233.5 17358.6 17359.1 17390.7 16014.2 16382.6 16936.7 16957.1 17037.7 4900.2 5096.8 5128.8 5131.4 5144.0 3648.3 5045.6 5623.9 5920.1 5931.4 5946.8 5972.3 5998.3 6003.8 6013.9 5685.1 5809.1 5832.6 5853.2 5860.5 4381.1 5083.9 5087.0 5102.1 5126.3 10823.3 11348.5 11366.9 11379.1 11382.1 1823.8 1843.3 1914.7 1932.8 1973.5 8104.8 8525.4 8573.4 8639.5 8712.4 1653.3 1714.9 1741.9 1752.9 1756.7 64539.0 66050.7 66192.3 66714.0 67127.0 9222.4 9524.7 9627.3 9635.5 9661.4 13075.5 13164.2 13194.6 13209.3 13229.5 6781.5 6933.7 7002.7 7073.6 7352.5 6149.9 6275.6 6448.8 6461.4 6470.5 3941.4 4008.3 4020.1 4112.5 4207.4 1587.9 1699.9 1742.9 1805.7 1839.9 828.3 886.5 888.5 895.4 992.4 15817.6 15906.7 16144.0 16151.8 16656.2 876.5 889.8 908.7 951.8 974.7 9255.2 9297.6 9346.4 9353.3 9357.8 375592.0 377128.0 386930.0 391832.0 392714.0 58768.7 71192.6 72632.6 72726.3 75203.0 855.9 894.4 939.9 942.6 945.3 15488.4 15532.6 15560.7 15886.1 16050.8 35431.5 36909.0 37291.8 37807.0 37915.6 47242.5 51527.7 51569.5 51768.0 52114.0 7180.5 7254.3 7365.6 7371.4 7628.3 10214.8 11498.7 11813.9 11885.8 12150.5 10143.9 10242.9 10365.2 10470.4 10486.3 4411.2 8436.4 9609.3 10336.9 10629.0 10316.8 10488.6 10502.2 10676.0 10695.9 7201.4 7398.4 7400.0 7493.4 7598.8 9923.6 9957.6 10087.5 10214.2 10346.0 15:40:01 INFO - PROCESS | 12413 | 15:40:01 INFO - PROCESS | 12413 | [#3] mootools.html Cycles:180 Average:5227.00 Median:5715.89 stddev:2906.01 (50.8%) stddev-sans-first:2899.92 15:40:01 INFO - PROCESS | 12413 | Values: 1399.4 1437.2 1563.3 1742.3 1755.8 7006.6 7350.2 7656.5 8238.8 8239.2 7528.8 7703.3 7818.3 7819.5 7832.3 2157.0 2227.7 2227.9 2229.1 2231.5 2166.5 2183.6 2192.2 2192.8 2198.2 2167.6 2170.0 2177.5 2181.4 2227.6 2092.0 2096.7 2104.9 2112.8 2113.3 2110.3 2128.6 2133.6 2142.8 2142.8 7733.2 7774.5 7782.8 7824.8 7833.9 4470.8 4538.7 4567.0 4577.8 4602.2 2851.0 2881.1 2964.8 2981.3 2990.3 824.2 854.0 862.1 864.7 869.6 10529.5 10562.2 10567.8 10593.5 10656.4 4187.0 4239.8 4309.5 4315.1 4345.8 8954.6 8963.0 9030.4 9047.1 9048.4 4475.4 4483.8 4539.9 4542.4 4553.2 3704.1 4064.0 4138.3 4149.5 4233.6 3575.9 3606.2 3663.9 3677.2 3700.5 1203.2 1211.8 1217.4 1236.5 1238.8 796.4 889.2 894.9 903.0 926.3 5448.3 5524.9 5571.5 5625.8 5745.6 927.3 939.2 974.1 988.3 1005.6 3814.8 3937.5 3953.8 3979.6 3993.5 9503.2 9710.8 9799.2 9853.6 9865.3 9695.0 9823.7 9847.7 9847.9 9858.8 7087.4 7344.6 7423.7 7459.0 7548.7 5686.2 5834.5 5864.7 5944.1 6002.5 8809.9 9035.1 9242.4 9304.0 9330.0 9158.7 9330.7 9338.0 9358.3 9381.3 6064.7 6553.4 6719.8 6994.2 7159.7 7682.5 7750.4 7797.2 7806.2 7810.2 6720.0 6882.3 6906.1 7007.9 7242.0 6726.2 6733.5 6770.3 6783.4 6877.6 6051.0 6258.3 6667.4 6668.2 6712.8 4867.3 4868.2 4884.0 4927.3 4988.9 4606.7 4656.2 4673.5 4750.1 4751.2 15:40:01 INFO - PROCESS | 12413 | 15:40:01 INFO - PROCESS | 12413 | [#4] prototype.html Cycles:180 Average:4348.75 Median:4981.81 stddev:1277.57 (25.6%) stddev-sans-first:1244.29 15:40:01 INFO - PROCESS | 12413 | Values: 289.6 292.3 294.5 298.1 299.0 4969.7 5028.3 5033.2 5034.3 5036.1 4953.1 4960.8 4964.2 4971.3 4979.8 3657.2 3730.7 3801.2 3824.4 3834.5 3824.3 3883.8 3892.2 3914.3 3915.1 3899.6 3900.0 3902.3 3908.7 3929.0 3789.2 3796.9 3859.8 3868.7 3921.8 3347.1 3371.9 3374.3 3387.5 3393.8 4733.5 4761.6 4792.5 4803.2 4805.4 4375.2 4404.4 4415.2 4417.2 4445.7 4990.5 5189.7 5192.8 5199.4 5216.6 3718.2 3722.0 3724.7 3732.9 3733.5 5462.5 5492.8 5507.3 5523.3 5549.3 3575.7 3827.6 3833.2 3844.0 3848.7 3869.9 3880.7 3888.3 3890.6 3897.4 4387.3 4406.5 4417.6 4428.6 4436.8 4983.9 5194.8 5238.5 5256.0 5262.3 1314.5 1319.6 1322.9 1324.1 1324.3 848.2 854.8 869.4 871.2 872.0 4561.6 4630.5 4650.3 4666.3 4670.6 5400.9 5410.8 5418.8 5419.2 5433.3 4416.9 4613.2 4657.6 4667.7 4689.2 2853.4 2884.9 2889.6 2892.4 2899.9 5129.6 5130.5 5136.6 5144.2 5151.6 5238.7 5506.4 5508.9 5541.8 5574.6 5051.1 5115.9 5127.2 5134.5 5155.4 5439.4 5454.4 5456.6 5461.3 5469.0 5233.2 5348.8 5352.2 5354.4 5359.5 5124.4 5130.4 5140.6 5148.2 5158.0 3740.3 3742.6 3756.8 3778.2 3781.8 5252.9 5416.4 5435.9 5445.1 5479.5 5281.8 5322.5 5336.1 5336.4 5337.7 5262.0 5287.6 5322.1 5325.6 5333.8 4990.6 5098.8 5169.9 5215.4 5220.3 5006.2 5103.4 5235.4 5291.0 5293.6 5101.2 5111.8 5125.5 5145.7 5156.0 15:40:01 INFO - PROCESS | 12413 | 15:40:01 INFO - PROCESS | 12413 | [#5] yui.html Cycles:180 Average:15855.11 Median:52236.37 stddev:20655.94 (39.5%) stddev-sans-first:20682.33 15:40:01 INFO - PROCESS | 12413 | Values: 650.4 674.8 737.4 737.9 759.4 11877.2 12681.6 12684.2 12819.1 12894.1 12697.5 12933.2 12938.9 12946.4 12946.9 626.2 778.1 795.0 796.4 797.7 769.7 795.7 797.2 801.2 801.4 810.5 813.7 820.4 822.4 822.6 807.5 808.4 808.9 814.0 814.9 592.1 592.7 594.7 595.3 595.5 12314.9 12383.1 12410.8 12429.6 12429.9 12894.2 13290.3 13326.7 13357.0 13518.6 10446.9 10566.6 10636.1 10809.5 10813.6 3336.9 3358.5 3388.1 3398.3 3414.9 56214.0 56352.4 56471.2 56970.7 57041.0 10491.2 10731.5 10787.0 10840.7 10952.7 16737.1 17566.4 19249.5 19267.5 19334.0 7092.1 7180.2 7234.3 7280.7 7283.9 3743.0 3853.8 3928.5 3934.4 3978.8 2898.5 3026.7 3027.9 3030.4 3030.8 548.4 548.7 556.4 558.4 565.5 587.6 620.0 621.6 633.2 633.9 8344.5 8805.2 8842.6 9048.8 9272.4 623.9 632.9 655.6 658.3 669.4 3863.8 3982.1 3994.1 4005.1 4221.3 54434.5 54903.0 55032.2 67790.0 88766.0 51181.7 55556.4 75319.6 77762.0 80575.0 56100.7 70743.3 70755.0 70783.6 71618.3 7999.0 8074.2 8117.5 8188.3 8255.0 42190.0 43215.4 43494.8 43766.6 44487.8 52062.7 52410.0 54119.7 59186.4 60813.7 10497.0 11159.4 11475.3 11661.3 11725.4 12288.2 12531.2 12854.2 12901.8 12969.4 11562.8 11861.8 12053.9 12118.3 12224.4 11384.8 11392.5 11630.3 11911.6 12013.8 11422.5 11464.7 11519.0 11684.0 11840.6 9416.0 9516.0 9521.0 9813.2 9936.9 9948.5 10073.3 10136.1 10145.2 10163.5 15:40:01 INFO - PROCESS | 12413 | -------- Summary: end -------- 15:40:01 INFO - PROCESS | 12413 | 15:40:02 INFO - TEST-INFO | 12413: exit 0 15:40:02 INFO - TEST-OK | dromaeo_css | took 1115792ms 15:40:02 INFO - TEST-START | kraken 15:40:02 INFO - operating with platform_type : linux_ 15:40:02 INFO - Initialising browser for kraken test... 15:40:02 INFO - TEST-INFO | started process 12649 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbvtAnH/profile http://localhost:59617/getInfo.html) 15:40:07 INFO - PROCESS | 12649 | __metrics Screen width/height:1600/1200 15:40:07 INFO - PROCESS | 12649 | colorDepth:24 15:40:07 INFO - PROCESS | 12649 | Browser inner width/height: 1024/697 15:40:07 INFO - PROCESS | 12649 | __metrics 15:40:08 ERROR - PROCESS | 12649 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2944: TypeError: this.tabs is undefined 15:40:09 INFO - TEST-INFO | 12649: exit 0 15:40:09 INFO - Browser initialized. 15:40:09 INFO - Running cycle 1/1 for kraken test... 15:40:09 INFO - TEST-INFO | started process 12770 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbvtAnH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:40:21 INFO - PROCESS | 12770 | RSS: Main: 168312832 15:40:21 INFO - PROCESS | 12770 | 15:40:24 INFO - PROCESS | 12770 | Cycle 1(1): loaded http://localhost:59617/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59617/tests/kraken/driver.html?testName=audio-beat-detection) 15:40:25 INFO - PROCESS | 12770 | RSS: Main: 172003328 15:40:25 INFO - PROCESS | 12770 | 15:40:27 INFO - PROCESS | 12770 | Cycle 1(1): loaded http://localhost:59617/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59617/tests/kraken/driver.html?testName=audio-dft) 15:40:28 INFO - PROCESS | 12770 | RSS: Main: 172081152 15:40:28 INFO - PROCESS | 12770 | 15:40:31 INFO - PROCESS | 12770 | Cycle 1(1): loaded http://localhost:59617/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59617/tests/kraken/driver.html?testName=audio-fft) 15:40:32 INFO - PROCESS | 12770 | RSS: Main: 167317504 15:40:32 INFO - PROCESS | 12770 | 15:40:34 INFO - PROCESS | 12770 | Cycle 1(1): loaded http://localhost:59617/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59617/tests/kraken/driver.html?testName=audio-oscillator) 15:40:34 INFO - PROCESS | 12770 | RSS: Main: 168329216 15:40:34 INFO - PROCESS | 12770 | 15:40:37 INFO - PROCESS | 12770 | Cycle 1(1): loaded http://localhost:59617/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59617/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:40:37 INFO - PROCESS | 12770 | RSS: Main: 168812544 15:40:37 INFO - PROCESS | 12770 | 15:40:40 INFO - PROCESS | 12770 | Cycle 1(1): loaded http://localhost:59617/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59617/tests/kraken/driver.html?testName=imaging-darkroom) 15:40:41 INFO - PROCESS | 12770 | RSS: Main: 168726528 15:40:41 INFO - PROCESS | 12770 | 15:40:45 INFO - PROCESS | 12770 | Cycle 1(1): loaded http://localhost:59617/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59617/tests/kraken/driver.html?testName=imaging-desaturate) 15:40:45 INFO - PROCESS | 12770 | RSS: Main: 166576128 15:40:45 INFO - PROCESS | 12770 | 15:40:48 INFO - PROCESS | 12770 | Cycle 1(1): loaded http://localhost:59617/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59617/tests/kraken/driver.html?testName=json-parse-financial) 15:40:49 INFO - PROCESS | 12770 | RSS: Main: 167645184 15:40:49 INFO - PROCESS | 12770 | 15:40:50 INFO - PROCESS | 12770 | Cycle 1(1): loaded http://localhost:59617/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59617/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:40:51 INFO - PROCESS | 12770 | RSS: Main: 168140800 15:40:51 INFO - PROCESS | 12770 | 15:40:53 INFO - PROCESS | 12770 | Cycle 1(1): loaded http://localhost:59617/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59617/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:40:54 INFO - PROCESS | 12770 | RSS: Main: 168099840 15:40:54 INFO - PROCESS | 12770 | 15:40:56 INFO - PROCESS | 12770 | Cycle 1(1): loaded http://localhost:59617/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59617/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:40:57 INFO - PROCESS | 12770 | RSS: Main: 168607744 15:40:57 INFO - PROCESS | 12770 | 15:40:59 INFO - PROCESS | 12770 | Cycle 1(1): loaded http://localhost:59617/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59617/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:41:00 INFO - PROCESS | 12770 | RSS: Main: 168898560 15:41:00 INFO - PROCESS | 12770 | 15:41:03 INFO - PROCESS | 12770 | Cycle 1(1): loaded http://localhost:59617/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59617/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:41:04 INFO - PROCESS | 12770 | RSS: Main: 168697856 15:41:04 INFO - PROCESS | 12770 | 15:41:05 INFO - PROCESS | 12770 | Cycle 1(1): loaded http://localhost:59617/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59617/tests/kraken/driver.html?testName=ai-astar) 15:41:06 INFO - PROCESS | 12770 | RSS: Main: 169226240 15:41:06 INFO - PROCESS | 12770 | 15:41:06 INFO - PROCESS | 12770 | __start_tp_report 15:41:06 INFO - PROCESS | 12770 | _x_x_mozilla_page_load 15:41:06 INFO - PROCESS | 12770 | _x_x_mozilla_page_load_details 15:41:06 INFO - PROCESS | 12770 | |i|pagename|runs| 15:41:06 INFO - PROCESS | 12770 | |0;ai-astar;115;110;113;113;113;113;114;113;114;114 15:41:06 INFO - PROCESS | 12770 | |1;audio-beat-detection;154;132;158;191;132;155;162;132;189;131 15:41:06 INFO - PROCESS | 12770 | |2;audio-dft;162;161;165;173;165;163;162;162;162;161 15:41:06 INFO - PROCESS | 12770 | |3;audio-fft;76;76;76;151;78;75;77;75;162;76 15:41:06 INFO - PROCESS | 12770 | |4;audio-oscillator;86;87;140;87;85;86;130;87;86;140 15:41:06 INFO - PROCESS | 12770 | |5;imaging-gaussian-blur;117;117;118;119;118;117;118;118;119;118 15:41:06 INFO - PROCESS | 12770 | |6;imaging-darkroom;147;147;148;147;148;147;148;147;151;151 15:41:06 INFO - PROCESS | 12770 | |7;imaging-desaturate;96;99;95;95;96;97;95;96;95;96 15:41:06 INFO - PROCESS | 12770 | |8;json-parse-financial;64;66;67;68;64;64;65;64;65;76 15:41:06 INFO - PROCESS | 12770 | |9;json-stringify-tinderbox;65;66;65;66;66;66;66;66;67;66 15:41:06 INFO - PROCESS | 12770 | |10;stanford-crypto-aes;84;84;90;84;97;91;87;85;112;86 15:41:06 INFO - PROCESS | 12770 | |11;stanford-crypto-ccm;143;135;136;142;143;133;144;136;155;136 15:41:06 INFO - PROCESS | 12770 | |12;stanford-crypto-pbkdf2;170;172;174;170;173;171;177;169;171;185 15:41:06 INFO - PROCESS | 12770 | |13;stanford-crypto-sha256-iterative;68;68;70;71;70;69;67;65;67;68 15:41:06 INFO - PROCESS | 12770 | __end_tp_report 15:41:06 INFO - PROCESS | 12770 | __start_cc_report 15:41:06 INFO - PROCESS | 12770 | _x_x_mozilla_cycle_collect,962 15:41:06 INFO - PROCESS | 12770 | __end_cc_report 15:41:06 INFO - PROCESS | 12770 | __startTimestamp1465252866083__endTimestamp 15:41:06 INFO - PROCESS | 12770 | 15:41:06 INFO - PROCESS | 12770 | ------- Summary: start ------- 15:41:06 INFO - PROCESS | 12770 | Number of tests: 14 15:41:06 INFO - PROCESS | 12770 | 15:41:06 INFO - PROCESS | 12770 | [#0] ai-astar Cycles:10 Average:113.20 Median:113.50 stddev:1.32 (1.2%) stddev-sans-first:1.22 15:41:06 INFO - PROCESS | 12770 | Values: 115.0 110.0 113.0 113.0 113.0 113.0 114.0 113.0 114.0 114.0 15:41:06 INFO - PROCESS | 12770 | 15:41:06 INFO - PROCESS | 12770 | [#1] audio-beat-detection Cycles:10 Average:153.60 Median:156.50 stddev:22.74 (14.5%) stddev-sans-first:24.12 15:41:06 INFO - PROCESS | 12770 | Values: 154.0 132.0 158.0 191.0 132.0 155.0 162.0 132.0 189.0 131.0 15:41:06 INFO - PROCESS | 12770 | 15:41:06 INFO - PROCESS | 12770 | [#2] audio-dft Cycles:10 Average:163.60 Median:162.50 stddev:3.60 (2.2%) stddev-sans-first:3.77 15:41:06 INFO - PROCESS | 12770 | Values: 162.0 161.0 165.0 173.0 165.0 163.0 162.0 162.0 162.0 161.0 15:41:06 INFO - PROCESS | 12770 | 15:41:06 INFO - PROCESS | 12770 | [#3] audio-fft Cycles:10 Average:92.20 Median:76.00 stddev:34.00 (44.7%) stddev-sans-first:35.55 15:41:06 INFO - PROCESS | 12770 | Values: 76.0 76.0 76.0 151.0 78.0 75.0 77.0 75.0 162.0 76.0 15:41:06 INFO - PROCESS | 12770 | 15:41:06 INFO - PROCESS | 12770 | [#4] audio-oscillator Cycles:10 Average:101.40 Median:86.00 stddev:24.50 (28.5%) stddev-sans-first:25.34 15:41:06 INFO - PROCESS | 12770 | Values: 86.0 87.0 140.0 87.0 85.0 86.0 130.0 87.0 86.0 140.0 15:41:06 INFO - PROCESS | 12770 | 15:41:06 INFO - PROCESS | 12770 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.74 (0.6%) stddev-sans-first:0.71 15:41:06 INFO - PROCESS | 12770 | Values: 117.0 117.0 118.0 119.0 118.0 117.0 118.0 118.0 119.0 118.0 15:41:06 INFO - PROCESS | 12770 | 15:41:06 INFO - PROCESS | 12770 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:1.60 (1.1%) stddev-sans-first:1.64 15:41:06 INFO - PROCESS | 12770 | Values: 147.0 147.0 148.0 147.0 148.0 147.0 148.0 147.0 151.0 151.0 15:41:06 INFO - PROCESS | 12770 | 15:41:06 INFO - PROCESS | 12770 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:1.25 (1.3%) stddev-sans-first:1.32 15:41:06 INFO - PROCESS | 12770 | Values: 96.0 99.0 95.0 95.0 96.0 97.0 95.0 96.0 95.0 96.0 15:41:06 INFO - PROCESS | 12770 | 15:41:06 INFO - PROCESS | 12770 | [#8] json-parse-financial Cycles:10 Average:66.30 Median:65.50 stddev:3.68 (5.6%) stddev-sans-first:3.81 15:41:06 INFO - PROCESS | 12770 | Values: 64.0 66.0 67.0 68.0 64.0 64.0 65.0 64.0 65.0 76.0 15:41:06 INFO - PROCESS | 12770 | 15:41:06 INFO - PROCESS | 12770 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.00 stddev:0.57 (0.9%) stddev-sans-first:0.50 15:41:06 INFO - PROCESS | 12770 | Values: 65.0 66.0 65.0 66.0 66.0 66.0 66.0 66.0 67.0 66.0 15:41:06 INFO - PROCESS | 12770 | 15:41:06 INFO - PROCESS | 12770 | [#10] stanford-crypto-aes Cycles:10 Average:90.00 Median:86.50 stddev:8.77 (10.1%) stddev-sans-first:9.03 15:41:06 INFO - PROCESS | 12770 | Values: 84.0 84.0 90.0 84.0 97.0 91.0 87.0 85.0 112.0 86.0 15:41:06 INFO - PROCESS | 12770 | 15:41:06 INFO - PROCESS | 12770 | [#11] stanford-crypto-ccm Cycles:10 Average:140.30 Median:142.50 stddev:6.53 (4.6%) stddev-sans-first:6.86 15:41:06 INFO - PROCESS | 12770 | Values: 143.0 135.0 136.0 142.0 143.0 133.0 144.0 136.0 155.0 136.0 15:41:06 INFO - PROCESS | 12770 | 15:41:06 INFO - PROCESS | 12770 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.20 Median:172.50 stddev:4.76 (2.8%) stddev-sans-first:4.90 15:41:06 INFO - PROCESS | 12770 | Values: 170.0 172.0 174.0 170.0 173.0 171.0 177.0 169.0 171.0 185.0 15:41:06 INFO - PROCESS | 12770 | 15:41:06 INFO - PROCESS | 12770 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.50 stddev:1.77 (2.6%) stddev-sans-first:1.87 15:41:06 INFO - PROCESS | 12770 | Values: 68.0 68.0 70.0 71.0 70.0 69.0 67.0 65.0 67.0 68.0 15:41:06 INFO - PROCESS | 12770 | -------- Summary: end -------- 15:41:06 INFO - PROCESS | 12770 | 15:41:07 INFO - TEST-INFO | 12770: exit 0 15:41:07 INFO - TEST-OK | kraken | took 64492ms 15:41:07 INFO - SUITE-END | took 1180s 15:41:07 INFO - Completed test suite (00:19:40) 15:41:07 INFO - javascript benchmark 15:41:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6348.802893874024, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2687.0998215597774, 2687.4759421912727, 2722.33302840804, 2730.5085084684747, 2732.740389662981, 4643.674942754009, 4715.575598196162, 4760.309755085519, 4764.0, 4791.329213910051, 4643.651726120537, 4777.307290442893, 4777.665563410554, 4808.639352048593, 4813.687110337834, 4342.044750154961, 4377.78111094444, 4462.709923854955, 4476.060027394235, 4480.843170489034, 4173.770442625654, 4466.039801442689, 4495.730256184623, 4504.617107545862, 4521.457425108992, 4336.631386332166, 4364.956350436487, 4397.670174736908, 4406.294992801137, 4475.239209334389, 4349.586789255016, 4352.36890650857, 4358.585934336233, 4359.215341238576, 4397.098594788061, 4363.80362883671, 4367.410399596046, 4375.431193944799, 4385.846495372647, 4402.207602631525, 4667.533246675339, 4720.362751028636, 4729.219678753002, 4742.0, 4748.5014073522125, 5168.2764412982215, 5175.0, 5190.195519694454, 5209.453007434203, 5214.661047031968, 5050.823221187241, 5185.55922746567, 5209.1665333546825, 5222.582193424517, 5225.085610018232, 4800.087983283165, 4861.611071114302, 4877.707337559757, 4903.068417000758, 4923.556879880756, 5298.735063246822, 5324.923642323214, 5353.250544923714, 5361.839144825662, 5389.27244821944, 4895.657303988686, 4942.258661200849, 5073.797048118107, 5099.847004589868, 5139.152039913447, 5096.235564665256, 5120.155174396183, 5143.4085080216255, 5146.588272938156, 5198.610104242197, 4935.185694360463, 5083.593312534988, 5102.0, 5115.846524604193, 5132.050570644443, 4894.951050489521, 5049.31834202378, 5088.542031217208, 5100.209467532539, 5168.224766285088, 4263.4031235627035, 4271.487421509377, 4287.3783301421745, 4293.162833247487, 4324.632406245441, 3704.0554658561896, 3717.3308804414924, 3762.4732537444233, 3801.6198380161763, 3824.1778017726324, 4428.579284967923, 4456.064226512404, 4461.754603496774, 4466.642668586505, 4494.685372023992, 5151.896962060738, 5171.922421163686, 5184.015037142931, 5190.792368305301, 5268.420473747885, 4502.347159661831, 4506.504284528699, 4529.456465224194, 4535.0, 4578.381918440968, 4493.910121797611, 4593.839215627437, 4620.237660786, 4631.907361852812, 4653.302004699254, 4901.975490122598, 4915.705057696549, 4935.975320123376, 4946.406431228275, 4977.950220497749, 5189.974050129726, 5223.164293712987, 5224.791008359775, 5232.215167724872, 5238.319018527567, 4869.756512174448, 4909.95090049095, 4926.7929357307685, 4937.851864444073, 4948.480409557089, 5156.303898973591, 5170.586353091669, 5172.19830926207, 5185.092608793521, 5218.66078704883, 5015.648904576645, 5173.896522069613, 5241.764120614658, 5245.055889939695, 5252.894942101213, 4792.137415265146, 4917.385326834145, 5043.697378157322, 5052.216906379517, 5088.313077734459, 4981.501849814989, 4998.500149984972, 5004.649674522749, 5010.649254552292, 5018.071656743514, 4759.0719809636785, 4828.985912958318, 4861.1006963711825, 4866.051120031701, 4945.307656927961, 5034.043531728959, 5052.494750525065, 5074.391073071255, 5102.770375333193, 5133.845984620468, 4926.729029903389, 4968.105740966516, 4975.427825799935, 4978.850634480971, 5025.874353141201], "value": 4724.47652827144, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.6097051578638, 592.7954855574827, 602.8432607522043, 606.9105954811114, 621.0683974038942, 39472.0, 41610.167796644084, 41649.167016659645, 41856.16287674245, 44531.0, 39188.80405597975, 39528.60471395285, 39612.0, 39751.0, 40025.199496010064, 7596.240375962415, 7725.922740772605, 7727.768166954972, 7733.651985660659, 7748.845023099535, 7653.502522336031, 7662.003939487887, 7704.114026886924, 7712.421568382366, 7721.343685786715, 7682.270184332508, 7688.34649054831, 7703.383729301642, 7719.922800771977, 7734.226577342249, 7674.117476490219, 7696.923030769676, 7716.498427602188, 7722.691092356271, 7744.148143704188, 7618.200088990631, 7708.152103268636, 7709.151993280735, 7745.1867553906595, 7763.961180194119, 36005.81997090024, 36248.0, 36472.541098356036, 36533.45199822005, 36637.81681091604, 3089.3821235752716, 3090.3355778507503, 3136.6549679535233, 3165.018844158318, 3377.9662203378143, 25799.87100064488, 27239.45521089587, 27946.860265698542, 27961.720382796117, 28025.57961630577, 3316.7512436567113, 3320.8505617247283, 3322.933541329184, 3333.4333163362285, 3345.7156141727983, 210907.0, 211480.0, 211967.0, 213298.0, 213323.80085792197, 28351.57472637912, 29031.27421814429, 50684.0, 50864.0, 50965.49034509608, 33737.0, 33806.49290260599, 33827.4925876112, 34004.1498962523, 34061.659383406346, 11993.0, 12129.241260017248, 12144.878551214375, 12149.392530373623, 12161.878381216251, 10509.106725928228, 10640.627578034731, 10641.467926603638, 10646.680599582025, 10658.840117398246, 7899.210078992055, 7950.840983180304, 7953.403494737918, 8031.919680803234, 8057.959710201529, 3095.4273459410083, 3109.6112985876766, 3143.339898621269, 3153.3220357623222, 3179.2846609513135, 878.0955615715823, 907.8002839375326, 987.5457289646699, 1025.2464438637596, 1047.1151876664208, 28165.43669126606, 28516.857415712788, 28588.28529286743, 28898.277543061173, 29017.12948611545, 928.7167413938679, 966.463612694947, 968.8298212005058, 1051.9421431821324, 1053.3995622495104, 14904.701905962036, 15053.924730376279, 15181.316840742193, 15244.771328430083, 15311.846881531264, 396300.07399852417, 397610.0, 400727.0, 401844.0, 402102.0, 49330.340404045, 49523.752381237864, 49774.0, 49848.50151498511, 50086.74956625266, 1214.2228973456995, 1217.713837248246, 1219.0552321950381, 1220.7558488302375, 1244.402686710366, 26853.731462685904, 27837.0, 28143.296417589725, 28157.859210703817, 28450.146495605164, 42459.0, 42570.57429425666, 42855.57144428516, 42921.785391072845, 43070.56929430665, 280330.0, 280842.0, 340662.0, 343135.0, 343207.0, 25097.49805003853, 25284.367890802878, 25505.0, 25652.871735641947, 26591.468170636865, 42024.36963445612, 42362.788186060105, 42505.36241956435, 42660.1467970645, 42956.57043429526, 35783.46324805182, 35827.82086089657, 36105.27789444144, 36252.456213157355, 36549.81725091358, 35434.29131417409, 35925.82037089798, 35948.28103437864, 35952.64047359493, 36308.636913631584, 35416.29167416689, 35711.46432803458, 36080.09799755027, 36182.27635447224, 36520.81739591285, 31234.68765312409, 33008.1747956303, 33034.339313214085, 33270.334593308486, 33369.0, 24823.0, 24928.626070608592, 25422.74577254204, 25737.0, 25861.224163275132], "value": 16312.081758515316, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.7355123330651, 353.98938031859046, 354.7516738283202, 358.73991356266725, 370.6478845097158, 15680.764788528168, 16233.512994610166, 17358.56603584908, 17359.132043397825, 17390.652186956253, 16014.19929003551, 16382.576704289864, 16936.661266774656, 16957.067361295125, 17037.7444338335, 4900.166971614816, 5096.8470945871495, 5128.846134615949, 5131.358580177478, 5144.0, 3648.343298206322, 5045.596352291808, 5623.8594035149035, 5920.082387229964, 5931.4068593140555, 5946.791862284821, 5972.343042265347, 5998.310194327664, 6003.8198854034445, 6013.879722405549, 5685.118806584986, 5809.099589563624, 5832.591718579701, 5853.180554722342, 5860.501857342131, 4381.145676593065, 5083.949160508385, 5087.0, 5102.132637451605, 5126.256692779563, 10823.29648572848, 11348.489317980711, 11366.943165284121, 11379.089672826154, 11382.089432845352, 1823.8358547730768, 1843.2626949220285, 1914.6840771272862, 1932.80671932807, 1973.4671638657626, 8104.756857294232, 8525.44584601999, 8573.356998225096, 8639.52482613456, 8712.433691810013, 1653.264297387663, 1714.9056801875893, 1741.912904354777, 1752.9211185496556, 1756.6925787987052, 64539.0, 66050.66974665096, 66192.33807661958, 66714.0, 67127.0, 9222.44665320083, 9524.714163587965, 9627.277954153467, 9635.470049147365, 9661.420314781135, 13075.542356017493, 13164.210147391188, 13194.604161875159, 13209.273489958145, 13229.470821167239, 6781.525293229427, 6933.653317334214, 7002.684879180449, 7073.61095139762, 7352.522086064496, 6149.877002459926, 6275.560710750295, 6448.838779030468, 6461.386168314003, 6470.479437332223, 3941.3693808990997, 4008.2985477541315, 4020.0753826619457, 4112.485939257593, 4207.431996680471, 1587.857092861648, 1699.8640108791267, 1742.9128543573024, 1805.6840052990674, 1839.8712090153829, 828.2876726015621, 886.5035580075049, 888.4624801994829, 895.4448242089946, 992.3648864726581, 15817.604559886095, 15906.681866362607, 16144.0, 16151.757723634155, 16656.16719164037, 876.5135349880877, 889.8264838356458, 908.6774195160623, 951.7906060666643, 974.6637410093506, 9255.167034966751, 9297.628094876265, 9346.392484488486, 9353.296338952328, 9357.812843743088, 375592.0, 377128.0, 386930.0, 391832.0, 392714.0, 58768.70615646894, 71192.64403677949, 72632.63683681653, 72726.27273727302, 75203.0, 855.9144085591391, 894.3605322194662, 939.9060093990684, 942.6417961174847, 945.2626950978248, 15488.380464781283, 15532.61168470752, 15560.688786223986, 15886.126263055643, 16050.839491604935, 35431.468527971585, 36909.0, 37291.81354093212, 37807.0, 37915.62084379121, 47242.52757472519, 51527.74236128795, 51569.48430515797, 51768.0, 52114.0, 7180.497365184387, 7254.347108760237, 7365.600535898377, 7371.447141464519, 7628.313451789366, 10214.846777298199, 11498.712532186762, 11813.940930295637, 11885.82171267449, 12150.453229604513, 10143.88417274114, 10242.948785256027, 10365.222608304559, 10470.424126673106, 10486.265961382935, 4411.1618792429335, 8436.409451338348, 9609.327347085917, 10336.896631033593, 10629.0, 10316.76198856142, 10488.580456781949, 10502.212334074822, 10676.0, 10695.89304106949, 7201.423886089205, 7398.371138453292, 7399.963000184965, 7493.400527957641, 7598.848023039398, 9923.55344009507, 9957.601695932082, 10087.495625218562, 10214.233932454947, 10346.0], "value": 7900.087349341194, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1399.4052527675738, 1437.1592618318284, 1563.2652653252967, 1742.3030787684916, 1755.8419742223198, 7006.579605223677, 7350.154732205798, 7656.502327348725, 8238.794030149249, 8239.176082391758, 7528.84942301155, 7703.3452156566755, 7818.335441487467, 7819.452638315321, 7832.334251588622, 2156.956860862778, 2227.721534808149, 2227.888605569723, 2229.0972156276734, 2231.497912969577, 2166.5125346797004, 2183.5632873425297, 2192.1888901106613, 2192.7697591752876, 2198.1976578548793, 2167.5773224221284, 2169.967450488244, 2177.5318306564086, 2181.4219231903558, 2227.587896239193, 2092.0, 2096.6540520814124, 2104.863183893042, 2112.7781582933876, 2113.2814842953317, 2110.2930518276394, 2128.606207851537, 2133.5839511295303, 2142.78572142786, 2142.817860481861, 7733.226677332278, 7774.494657847222, 7782.766517004499, 7824.765257042298, 7833.882491762628, 4470.75410852403, 4538.659600529973, 4566.954330456686, 4577.8397756078375, 4602.240630295997, 2850.957235641467, 2881.063654312357, 2964.762818974477, 2981.344104297051, 2990.3421247325555, 824.1675907333636, 854.03920589337, 862.1464749897619, 864.6627815152095, 869.6173683579204, 10529.526171322308, 10562.20783441245, 10567.78864422715, 10593.523291451826, 10656.360618362924, 4186.958130418718, 4239.766812825324, 4309.48286205651, 4315.115401342718, 4345.826166953287, 8954.597043133075, 8962.955185224033, 9030.36787424887, 9047.095290471032, 9048.41185322952, 4475.351074094238, 4483.775811209492, 4539.886502837389, 4542.409486766699, 4553.248713962159, 3704.0554658561896, 4063.959360406417, 4138.275801734684, 4149.502059752849, 4233.555476674905, 3575.94636080459, 3606.2246616977477, 3663.9267214656093, 3677.2277821657754, 3700.4634328022826, 1203.18784820246, 1211.8242854786006, 1217.3669691760413, 1236.511577926714, 1238.8327575777334, 796.3708670150517, 889.208604342136, 894.9284057275403, 902.9593668284812, 926.282131348197, 5448.291722076105, 5524.944750552443, 5571.526420254243, 5625.803096891589, 5745.569082318842, 927.3091546797679, 939.2110627073291, 974.1281553010158, 988.2538683294067, 1005.582683186484, 3814.7520411173186, 3937.527496700357, 3953.8220780064967, 3979.621935916083, 3993.480847489866, 9503.19222866064, 9710.805783884283, 9799.167070799062, 9853.605855765833, 9865.309428339948, 9695.0, 9823.705288841345, 9847.704568862946, 9847.852282215772, 9858.753531161636, 7087.433005359559, 7344.559326440431, 7423.740169094164, 7459.030326057577, 7548.698052077855, 5686.203931449683, 5834.533237341087, 5864.67744274069, 5944.078667806497, 6002.459778619946, 8809.911900881165, 9035.096490350912, 9242.445453272825, 9304.023077577027, 9329.953350233205, 9158.725238242863, 9330.673426430314, 9337.953310233677, 9358.344915855825, 9381.343305968516, 6064.727087280995, 6553.4101930826455, 6719.764808231688, 6994.160700715946, 7159.749408770668, 7682.500637458547, 7750.379969602305, 7797.181295963842, 7806.219378062148, 7810.179931107379, 6720.0, 6882.277360877236, 6906.06768086322, 7007.859842803014, 7242.0, 6726.159230096238, 6733.461323094043, 6770.255271920183, 6783.3555812197765, 6877.552959057645, 6050.969745151246, 6258.311585725475, 6667.399934005963, 6668.166479190101, 6712.765053223114, 4867.269909513601, 4868.2210846264425, 4883.975580122076, 4927.347474436142, 4988.850334489971, 4606.654500912378, 4656.208444564364, 4673.532646735299, 4750.07373562152, 4751.216049351819], "value": 4218.263719298012, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [289.6393989483094, 292.27515760912934, 294.4787725725465, 298.0833935647883, 298.9715976982186, 4969.6521243512925, 5028.270900719398, 5033.219850923104, 5034.320366750488, 5036.118679231138, 4953.083679519292, 4960.751962401883, 4964.156093464111, 4971.254311853215, 4979.751012449381, 3657.1954170082604, 3730.7388482806214, 3801.2017476329866, 3824.445455408964, 3834.482344883433, 3824.2542704172697, 3883.76697398157, 3892.2215556888596, 3914.3149948758996, 3915.1386694927214, 3899.6490315871565, 3900.010994392852, 3902.2585708715396, 3908.687305015606, 3928.9803550982206, 3789.166383395676, 3796.9430458543143, 3859.7841679870753, 3868.6711629511524, 3921.8431262749455, 3347.1130150510135, 3371.9494207586904, 3374.257663314067, 3387.4580067189377, 3393.8472768725464, 4733.502982186856, 4761.619250332268, 4792.544708252711, 4803.231482962709, 4805.351277577517, 4375.190589740908, 4404.427424434835, 4415.227335216325, 4417.160739459525, 4445.6660253367245, 4990.525900039491, 5189.714565698885, 5192.844214673566, 5199.376074871039, 5216.58267338612, 3718.219173973469, 3722.032271609401, 3724.6647801697704, 3732.850685972558, 3733.4959780429567, 5462.535684466825, 5492.835214943558, 5507.284053073115, 5523.342997100894, 5549.306336707911, 3575.66031227033, 3827.6172382762056, 3833.2333533293454, 3843.9807800960816, 3848.749831260959, 3869.903252418712, 3880.6701430378735, 3888.2612303662213, 3890.6498415142773, 3897.3569361055675, 4387.310885309179, 4406.471223453142, 4417.580329868657, 4428.623566996777, 4436.800343984529, 4983.875403114878, 5194.792208311701, 5238.5023422774775, 5255.973720131375, 5262.2632831403635, 1314.4676406055562, 1319.5975227555496, 1322.9470821167238, 1324.1326930860303, 1324.265032906746, 848.2483671218913, 854.8033952191031, 869.3740506835069, 871.1549796697194, 871.9869201961976, 4561.612262957619, 4630.490646028934, 4650.302454631832, 4666.296801667367, 4670.602998745077, 5400.891982160335, 5410.83767486976, 5418.810341638024, 5419.160030195326, 5433.320834895638, 4416.933745993749, 4613.2388155953895, 4657.5575320344515, 4667.6732628716345, 4689.179393606105, 2853.4150499147627, 2884.8990285339914, 2889.624348834638, 2892.421515696869, 2899.855007249629, 5129.64092513528, 5130.461301563282, 5136.613114459075, 5144.202648589475, 5151.5878729701535, 5238.711870847063, 5506.384467377963, 5508.944910550923, 5541.806036788693, 5574.554035677217, 5051.055343692705, 5115.923261151086, 5127.230915362726, 5134.5378915897745, 5155.432902380735, 5439.374471935778, 5454.427285135003, 5456.563474921917, 5461.262729531462, 5468.972655136698, 5233.241180028951, 5348.839534813962, 5352.223927530564, 5354.3574771027725, 5359.464053594609, 5124.3602047345985, 5130.384353877558, 5140.56305214061, 5148.2020286855595, 5157.974210128926, 3740.2893450244364, 3742.5883152853708, 3756.830942607644, 3778.24435112984, 3781.829817658157, 5252.867247788667, 5416.37711663148, 5435.945640543544, 5445.128779395278, 5479.53423958968, 5281.841544753664, 5322.520973112439, 5336.0661884170895, 5336.386315573759, 5337.653052551572, 5261.973690131525, 5287.603429742861, 5322.068637988259, 5325.600579956441, 5333.813316533902, 4990.625703072212, 5098.847034588968, 5169.870753231199, 5215.400228973716, 5220.295260139833, 5006.173981293192, 5103.413107492686, 5235.397929238034, 5291.0, 5293.550048245788, 5101.183810590288, 5111.821086261963, 5125.461826508163, 5145.716985565829, 5156.020356132323], "value": 3936.1647772412794, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [650.3951325267501, 674.8076798112539, 737.3732327521604, 737.8561180569791, 759.4380158682575, 11877.227980181293, 12681.556145534909, 12684.175528590635, 12819.102662813595, 12894.097413181082, 12697.492100316, 12933.224006559589, 12938.870611293883, 12946.35268236589, 12946.870531294684, 626.1984659635651, 778.1168373895626, 795.0459448661601, 796.3549524884833, 797.7088362747613, 769.6613490064353, 795.6896810244009, 797.2107613462688, 801.1947992267762, 801.3789313282194, 810.5015415519472, 813.6989313953845, 820.3888103363003, 822.4489591973393, 822.6051495282268, 807.5397023696495, 808.4017826808149, 808.8786681997689, 813.9918600813975, 814.9062857771373, 592.1236569876563, 592.6799528254737, 594.6551000419746, 595.2678205806882, 595.487880422836, 12314.876851231462, 12383.133180677356, 12410.75178496425, 12429.564965226264, 12429.937850310691, 12894.161879477897, 13290.3354832258, 13326.733465330639, 13357.0, 13518.59444216675, 10446.895531044669, 10566.577336906514, 10636.149108071335, 10809.513571889283, 10813.567457301699, 3336.9481947249537, 3358.5465962095295, 3388.0682812226587, 3398.2863598644312, 3414.9146271343166, 56214.0, 56352.43647563513, 56471.15293270604, 56970.715146424416, 57041.0, 10491.16070714341, 10731.463426828628, 10786.999999999844, 10840.674779756462, 10952.726181845359, 16737.07946062954, 17566.385176519016, 19249.51876203106, 19267.51831204203, 19334.033298335307, 7092.113485814273, 7180.1742799578715, 7234.312740289664, 7280.708771649075, 7283.8543229136185, 3742.9812850935573, 3853.807309634507, 3928.46965659638, 3934.390169523728, 3978.8010599469912, 2898.478273910674, 3026.7124623160767, 3027.9394412111633, 3030.3636236390166, 3030.848457577112, 548.410458756838, 548.6872482684911, 556.4379976224043, 558.4052983572483, 565.4543365652083, 587.6297932302707, 620.0, 621.6208113051035, 633.2306247908721, 633.9397757213058, 8344.499330040217, 8805.16350946659, 8842.602082906285, 9048.819023619622, 9272.443653380818, 623.863268306059, 632.8702615963716, 655.5738769799668, 658.2747425657781, 669.437672355224, 3863.768173909574, 3982.143839074613, 3994.141259629194, 4005.118873847749, 4221.303484924953, 54434.45565544294, 54903.0, 55032.17451738227, 67790.0, 88766.0, 51181.7440912793, 55556.44443555594, 75319.62340188264, 77762.0, 80575.0, 56100.71949640226, 70743.2925670747, 70755.0, 70783.64608177029, 71618.28381716117, 7999.0, 8074.192580741878, 8117.472364296538, 8188.344932405513, 8255.0, 42190.0, 43215.35176972411, 43494.78252608717, 43766.56233437625, 44487.77756111199, 52062.73968630133, 52410.0, 54119.729401354314, 59186.40813591809, 60813.69593152006, 10497.004472196524, 11159.442027898735, 11475.311481311148, 11661.300321980709, 11725.35510546894, 12288.201266917979, 12531.248125112523, 12854.228746275254, 12901.806472902726, 12969.41637626328, 11562.76874462523, 11861.822072668745, 12053.879461205275, 12118.272903625812, 12224.388780561114, 11384.829227561428, 11392.544298227978, 11630.302181869114, 11911.583094591648, 12013.819792702941, 11422.543098276308, 11464.656060318204, 11519.0, 11684.0, 11840.585579504675, 9415.952920235355, 9516.0, 9521.0, 9813.165880900204, 9936.850947235942, 9948.502574871372, 10073.345232559861, 10136.138428233387, 10145.239107066853, 10163.542640581043], "value": 6477.47396788199, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1590.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 110.0, 113.0, 113.0, 113.0, 113.0, 114.0, 113.0, 114.0, 114.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 132.0, 158.0, 191.0, 132.0, 155.0, 162.0, 132.0, 189.0, 131.0], "value": 153.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 165.0, 173.0, 165.0, 163.0, 162.0, 162.0, 162.0, 161.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 151.0, 78.0, 75.0, 77.0, 75.0, 162.0, 76.0], "value": 92.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 140.0, 87.0, 85.0, 86.0, 130.0, 87.0, 86.0, 140.0], "value": 101.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 119.0, 118.0, 117.0, 118.0, 118.0, 119.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 147.0, 148.0, 147.0, 148.0, 147.0, 151.0, 151.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 99.0, 95.0, 95.0, 96.0, 97.0, 95.0, 96.0, 95.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 67.0, 68.0, 64.0, 64.0, 65.0, 64.0, 65.0, 76.0], "value": 66.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 66.0, 66.0, 66.0, 66.0, 66.0, 67.0, 66.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 90.0, 84.0, 97.0, 91.0, 87.0, 85.0, 112.0, 86.0], "value": 90.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 135.0, 136.0, 142.0, 143.0, 133.0, 144.0, 136.0, 155.0, 136.0], "value": 140.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 172.0, 174.0, 170.0, 173.0, 171.0, 177.0, 169.0, 171.0, 185.0], "value": 173.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 70.0, 71.0, 70.0, 69.0, 67.0, 65.0, 67.0, 68.0], "value": 68.3, "unit": "score"}]}]} 15:41:07 INFO - Return code: 0 15:41:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:41:07 ERROR - # TBPL SUCCESS # 15:41:07 INFO - Running post-action listener: _resource_record_post_action 15:41:07 INFO - ##### 15:41:07 INFO - ##### Finished run-tests step (success) 15:41:07 INFO - ##### 15:41:07 INFO - Running post-run listener: _resource_record_post_run 15:41:07 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 522043392; Read time: 12; Write time: 610884 15:41:07 INFO - TinderboxPrint: CPU usage
13.4% 15:41:07 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 15:41:07 INFO - TinderboxPrint: I/O write bytes / time
522,043,392 / 610,884 15:41:07 INFO - TinderboxPrint: CPU idle
8,265.8 (86.5%) 15:41:07 INFO - TinderboxPrint: CPU user
1,226.6 (12.8%) 15:41:07 INFO - TinderboxPrint: Swap in / out
0 / 0 15:41:07 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 235077632; Read time: 0; Write time: 342780 15:41:07 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 280395776; Read time: 12; Write time: 265820 15:41:08 INFO - Running post-run listener: _upload_blobber_files 15:41:08 INFO - Blob upload gear active. 15:41:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:41:08 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 15:41:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:41:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:41:08 INFO - (blobuploader) - INFO - Open directory for files ... 15:41:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:41:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:41:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:41:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:41:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:41:09 INFO - (blobuploader) - INFO - Done attempting. 15:41:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:41:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:41:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:41:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:41:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:41:14 INFO - (blobuploader) - INFO - Done attempting. 15:41:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:41:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:41:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:41:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:41:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:41:15 INFO - (blobuploader) - INFO - Done attempting. 15:41:15 INFO - (blobuploader) - INFO - Iteration through files over. 15:41:15 INFO - Return code: 0 15:41:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:41:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:41:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/470a078f5a6d6ebcdf1f26df87529e4326d76c7633bb57e2d71bac2584840936c166a8b7ab6b99221baa3bfaa43761bf79516dc8081f4e32f3b1295459b8abd6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/661c0914f35691904b032fad1c090392076620033738b10bdb4f2370373a42488a4910031ddc9fcdbabe8ddee55a27894db1eccb326aef7aa678f2271841ac5d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b627a80a7930afe18692d710aa8e3ef2d1c29eb51025ebf625da8ea805a7b5daf97789ca9f7657be3ba898b18eac6a2e8f68aa8c645adf7c908f5d0a0064bdfe"} 15:41:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:41:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:41:15 INFO - Contents: 15:41:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/470a078f5a6d6ebcdf1f26df87529e4326d76c7633bb57e2d71bac2584840936c166a8b7ab6b99221baa3bfaa43761bf79516dc8081f4e32f3b1295459b8abd6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/661c0914f35691904b032fad1c090392076620033738b10bdb4f2370373a42488a4910031ddc9fcdbabe8ddee55a27894db1eccb326aef7aa678f2271841ac5d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b627a80a7930afe18692d710aa8e3ef2d1c29eb51025ebf625da8ea805a7b5daf97789ca9f7657be3ba898b18eac6a2e8f68aa8c645adf7c908f5d0a0064bdfe"} 15:41:15 INFO - Running post-run listener: copy_logs_to_upload_dir 15:41:15 INFO - Copying logs to upload dir... 15:41:15 INFO - mkdir: /builds/slave/test/build/upload/logs 15:41:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.614120 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-06-06 15:41:14.925885) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 15:41:14.930193) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1465251632.247339-392662337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/470a078f5a6d6ebcdf1f26df87529e4326d76c7633bb57e2d71bac2584840936c166a8b7ab6b99221baa3bfaa43761bf79516dc8081f4e32f3b1295459b8abd6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/661c0914f35691904b032fad1c090392076620033738b10bdb4f2370373a42488a4910031ddc9fcdbabe8ddee55a27894db1eccb326aef7aa678f2271841ac5d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b627a80a7930afe18692d710aa8e3ef2d1c29eb51025ebf625da8ea805a7b5daf97789ca9f7657be3ba898b18eac6a2e8f68aa8c645adf7c908f5d0a0064bdfe"} build_url:https://queue.taskcluster.net/v1/task/Bw3kHOHMQU2wgY-ODj17pQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011230 build_url: 'https://queue.taskcluster.net/v1/task/Bw3kHOHMQU2wgY-ODj17pQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/470a078f5a6d6ebcdf1f26df87529e4326d76c7633bb57e2d71bac2584840936c166a8b7ab6b99221baa3bfaa43761bf79516dc8081f4e32f3b1295459b8abd6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/661c0914f35691904b032fad1c090392076620033738b10bdb4f2370373a42488a4910031ddc9fcdbabe8ddee55a27894db1eccb326aef7aa678f2271841ac5d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b627a80a7930afe18692d710aa8e3ef2d1c29eb51025ebf625da8ea805a7b5daf97789ca9f7657be3ba898b18eac6a2e8f68aa8c645adf7c908f5d0a0064bdfe"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 15:41:14.962321) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 15:41:14.962879) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1465251632.247339-392662337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004546 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 15:41:15.045404) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 15:41:15.045738) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 15:41:15.046023) ========= ========= Total master_lag: 0.16 =========