builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-006 starttime: 1466198245.59 results: success (0) buildid: 20160617113028 builduid: 2ebf505eaab744e5a26b598fb7969773 revision: 530e96008b7e987c75ddbab59cabdc11f9bbabb9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-17 14:17:25.594279) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-17 14:17:25.594859) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-17 14:17:25.595157) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-17 14:17:25.679333) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 14:17:25.679630) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1466196116.115765-315994287 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-17 14:17:25-- 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% 43.2M=0s 2016-06-17 14:17:26 (43.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.142961 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 14:17:25.848805) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 14:17:25.849126) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1466196116.115765-315994287 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016265 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 14:17:25.898445) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 14:17:25.898820) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 530e96008b7e987c75ddbab59cabdc11f9bbabb9 --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 530e96008b7e987c75ddbab59cabdc11f9bbabb9 --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=e31afd3c0f0de4e86ebe4d94000001b5-1466196116.115765-315994287 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-17 14:17:26,194 truncating revision to first 12 chars 2016-06-17 14:17:26,194 Setting DEBUG logging. 2016-06-17 14:17:26,194 attempt 1/10 2016-06-17 14:17:26,194 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/530e96008b7e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-17 14:17:26,501 unpacking tar archive at: fx-team-530e96008b7e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.653462 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 14:17:26.566070) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-17 14:17:26.566414) ========= script_repo_revision: 530e96008b7e987c75ddbab59cabdc11f9bbabb9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-17 14:17:26.566995) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-17 14:17:26.567274) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-17 14:17:26.578462) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-06-17 14:17:26.578837) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e31afd3c0f0de4e86ebe4d94000001b5-1466196116.115765-315994287 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:17:26 INFO - MultiFileLogger online at 20160617 14:17:26 in /builds/slave/test 14:17:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:17:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:17:26 INFO - {'append_to_log': False, 14:17:26 INFO - 'base_work_dir': '/builds/slave/test', 14:17:26 INFO - 'blob_upload_branch': 'Fx-Team', 14:17:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:17:26 INFO - 'branch': 'Fx-Team', 14:17:26 INFO - 'buildbot_json_path': 'buildprops.json', 14:17:26 INFO - 'config_files': ('talos/linux_config.py',), 14:17:26 INFO - 'default_actions': ('clobber', 14:17:26 INFO - 'read-buildbot-config', 14:17:26 INFO - 'download-and-extract', 14:17:26 INFO - 'populate-webroot', 14:17:26 INFO - 'create-virtualenv', 14:17:26 INFO - 'install', 14:17:26 INFO - 'run-tests'), 14:17:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:17:26 INFO - 'download_minidump_stackwalk': True, 14:17:26 INFO - 'download_symbols': 'ondemand', 14:17:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:17:26 INFO - 'tooltool.py': '/tools/tooltool.py', 14:17:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:17:26 INFO - '/tools/misc-python/virtualenv.py')}, 14:17:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:17:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:17:26 INFO - 'installer_path': 'installer.exe', 14:17:26 INFO - 'log_level': 'info', 14:17:26 INFO - 'log_name': 'talos', 14:17:26 INFO - 'log_to_console': True, 14:17:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:17:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:17:26 INFO - 'opt_config_files': (), 14:17:26 INFO - 'pip_index': False, 14:17:26 INFO - 'sps_profile': False, 14:17:26 INFO - 'sps_profile_interval': 0, 14:17:26 INFO - 'suite': 'dromaeojs-e10s', 14:17:26 INFO - 'system_bits': '32', 14:17:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:17:26 INFO - 'title': 'talos-linux64-ix-006', 14:17:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:17:26 INFO - 'use_talos_json': True, 14:17:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:17:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:17:26 INFO - 'work_dir': 'build'} 14:17:26 INFO - ##### 14:17:26 INFO - ##### Running clobber step. 14:17:26 INFO - ##### 14:17:26 INFO - Running pre-action listener: _resource_record_pre_action 14:17:26 INFO - Running main action method: clobber 14:17:26 INFO - rmtree: /builds/slave/test/build 14:17:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:17:27 INFO - Running post-action listener: _resource_record_post_action 14:17:27 INFO - ##### 14:17:27 INFO - ##### Finished clobber step (success) 14:17:27 INFO - ##### 14:17:27 INFO - ##### 14:17:27 INFO - ##### Running read-buildbot-config step. 14:17:27 INFO - ##### 14:17:27 INFO - Running pre-action listener: _resource_record_pre_action 14:17:27 INFO - Running main action method: read_buildbot_config 14:17:27 INFO - Using buildbot properties: 14:17:27 INFO - { 14:17:27 INFO - "project": "", 14:17:27 INFO - "product": "firefox", 14:17:27 INFO - "script_repo_revision": "production", 14:17:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 14:17:27 INFO - "repository": "", 14:17:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 14:17:27 INFO - "buildid": "20160617113028", 14:17:27 INFO - "pgo_build": "True", 14:17:27 INFO - "basedir": "/builds/slave/test", 14:17:27 INFO - "buildnumber": 486, 14:17:27 INFO - "slavename": "talos-linux64-ix-006", 14:17:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:17:27 INFO - "platform": "ubuntu64_hw", 14:17:27 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:17:27 INFO - "branch": "fx-team", 14:17:27 INFO - "repo_path": "integration/fx-team", 14:17:27 INFO - "revision": "530e96008b7e987c75ddbab59cabdc11f9bbabb9", 14:17:27 INFO - "stage_platform": "linux64-pgo", 14:17:27 INFO - "builduid": "2ebf505eaab744e5a26b598fb7969773", 14:17:27 INFO - "slavebuilddir": "test" 14:17:27 INFO - } 14:17:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 14:17:27 INFO - Running post-action listener: _resource_record_post_action 14:17:27 INFO - ##### 14:17:27 INFO - ##### Finished read-buildbot-config step (success) 14:17:27 INFO - ##### 14:17:27 INFO - ##### 14:17:27 INFO - ##### Running download-and-extract step. 14:17:27 INFO - ##### 14:17:27 INFO - Running pre-action listener: _resource_record_pre_action 14:17:27 INFO - Running main action method: download_and_extract 14:17:27 INFO - mkdir: /builds/slave/test/build/tests 14:17:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:27 INFO - https://queue.taskcluster.net/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:17:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:17:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:17:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:17:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:17:30 INFO - Downloaded 1361 bytes. 14:17:30 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:17:30 INFO - Using the following test package requirements: 14:17:30 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:17:30 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:17:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:17:30 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:17:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:17:30 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:17:30 INFO - u'jsshell-linux-x86_64.zip'], 14:17:30 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:17:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:17:30 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:17:30 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:17:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:17:30 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:17:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:17:30 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:17:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:17:30 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:17:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:17:30 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:17:30 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')]} 14:17:30 INFO - https://queue.taskcluster.net/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:17:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:17:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:17:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:17:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:17:33 INFO - Downloaded 24221020 bytes. 14:17:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:17:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:17:34 INFO - Return code: 0 14:17:34 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:17: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')]} 14:17:34 INFO - https://queue.taskcluster.net/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:17:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:17:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:17:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:17:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:17:36 INFO - Downloaded 24221020 bytes. 14:17:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:17:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:17:38 INFO - Return code: 0 14:17:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:38 INFO - https://queue.taskcluster.net/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:17:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:17:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:17:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:17:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:17:39 INFO - Downloaded 14405384 bytes. 14:17:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:17:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:17:39 INFO - Return code: 0 14:17:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:39 INFO - https://queue.taskcluster.net/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:17:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:17:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:17:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:17:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:17:41 INFO - Downloaded 59382147 bytes. 14:17:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:17:41 INFO - mkdir: /builds/slave/test/properties 14:17:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:17:41 INFO - Writing to file /builds/slave/test/properties/build_url 14:17:41 INFO - Contents: 14:17:41 INFO - build_url:https://queue.taskcluster.net/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:17:42 INFO - Running post-action listener: _resource_record_post_action 14:17:42 INFO - Running post-action listener: set_extra_try_arguments 14:17:42 INFO - ##### 14:17:42 INFO - ##### Finished download-and-extract step (success) 14:17:42 INFO - ##### 14:17:42 INFO - ##### 14:17:42 INFO - ##### Running populate-webroot step. 14:17:42 INFO - ##### 14:17:42 INFO - Running pre-action listener: _resource_record_pre_action 14:17:42 INFO - Running main action method: populate_webroot 14:17:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:17:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:17:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:17:42 INFO - '--tppagecycles', 14:17:42 INFO - '7'], 14:17:42 INFO - 'tests': ['tsvgm']}}, 14:17:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:17:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:17:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:17:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:17:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:17:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:17:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:42 INFO - 'talos_options': ['--disable-e10s'], 14:17:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:17:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:17:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:42 INFO - 'talos_options': ['--disable-e10s'], 14:17:42 INFO - 'tests': ['damp', 'tps']}, 14:17:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:42 INFO - 'tests': ['damp', 'tps']}, 14:17:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:17:42 INFO - 'tests': ['dromaeo_dom']}, 14:17:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:17:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:17:42 INFO - 'tests': ['basic_compositor_video']}, 14:17:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:17:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:17:42 INFO - 'tests': ['a11yr', 14:17:42 INFO - 'ts_paint', 14:17:42 INFO - 'tpaint', 14:17:42 INFO - 'sessionrestore', 14:17:42 INFO - 'sessionrestore_no_auto_restore', 14:17:42 INFO - 'tabpaint']}, 14:17:42 INFO - 'other-e10s': {'tests': ['a11yr', 14:17:42 INFO - 'ts_paint', 14:17:42 INFO - 'tpaint', 14:17:42 INFO - 'sessionrestore', 14:17:42 INFO - 'sessionrestore_no_auto_restore', 14:17:42 INFO - 'tabpaint']}, 14:17:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:17:42 INFO - 'ts_paint', 14:17:42 INFO - 'tpaint', 14:17:42 INFO - 'sessionrestore', 14:17:42 INFO - 'sessionrestore_no_auto_restore', 14:17:42 INFO - 'tabpaint']}, 14:17:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:17:42 INFO - 'ts_paint', 14:17:42 INFO - 'tpaint', 14:17:42 INFO - 'sessionrestore', 14:17:42 INFO - 'sessionrestore_no_auto_restore', 14:17:42 INFO - 'tabpaint']}, 14:17:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:17:42 INFO - 'tests': ['a11yr', 14:17:42 INFO - 'ts_paint', 14:17:42 INFO - 'tpaint', 14:17:42 INFO - 'sessionrestore', 14:17:42 INFO - 'sessionrestore_no_auto_restore', 14:17:42 INFO - 'tabpaint']}, 14:17:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:17:42 INFO - 'tests': ['a11yr', 14:17:42 INFO - 'ts_paint', 14:17:42 INFO - 'tpaint', 14:17:42 INFO - 'sessionrestore', 14:17:42 INFO - 'sessionrestore_no_auto_restore', 14:17:42 INFO - 'tabpaint']}, 14:17:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:17:42 INFO - 'tests': ['tsvgx', 14:17:42 INFO - 'tsvgr_opacity', 14:17:42 INFO - 'tart', 14:17:42 INFO - 'tscrollx', 14:17:42 INFO - 'cart']}, 14:17:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:17:42 INFO - 'tsvgr_opacity', 14:17:42 INFO - 'tart', 14:17:42 INFO - 'tscrollx', 14:17:42 INFO - 'cart']}, 14:17:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:42 INFO - 'talos_options': ['--disable-e10s'], 14:17:42 INFO - 'tests': ['tp5o']}, 14:17:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:42 INFO - 'tests': ['tp5o']}, 14:17:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:42 INFO - 'talos_options': ['--disable-e10s', 14:17:42 INFO - '--xperf_path', 14:17:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:17:42 INFO - 'tests': ['tp5n']}, 14:17:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:42 INFO - 'talos_options': ['--xperf_path', 14:17:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:17:42 INFO - 'tests': ['tp5n']}}, 14:17:42 INFO - 'talos.zip': {'path': '', 14:17:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:17:42 INFO - Running post-action listener: _resource_record_post_action 14:17:42 INFO - ##### 14:17:42 INFO - ##### Finished populate-webroot step (success) 14:17:42 INFO - ##### 14:17:42 INFO - ##### 14:17:42 INFO - ##### Running create-virtualenv step. 14:17:42 INFO - ##### 14:17:42 INFO - Running pre-action listener: _resource_record_pre_action 14:17:42 INFO - Running main action method: create_virtualenv 14:17:42 INFO - Creating virtualenv /builds/slave/test/build/venv 14:17:42 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:17:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:17:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:17:42 INFO - Using real prefix '/usr' 14:17:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:17:43 INFO - Installing distribute.............................................................................................................................................................................................done. 14:17:45 INFO - Installing pip.................done. 14:17:45 INFO - Return code: 0 14:17:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:17:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f405f97df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a49a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a46d00>, '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 0x1a47ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a47f60>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1466196116.115765-315994287', '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 14:17:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:17:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:17:45 INFO - Using env: {'DISPLAY': ':0', 14:17:45 INFO - 'HOME': '/home/cltbld', 14:17:45 INFO - 'LANG': 'en_US.UTF-8', 14:17:45 INFO - 'LANGUAGE': 'en_US:en', 14:17:45 INFO - 'LOGNAME': 'cltbld', 14:17:45 INFO - 'MAIL': '/var/mail/cltbld', 14:17:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:45 INFO - 'MOZ_NO_REMOTE': '1', 14:17:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:45 INFO - 'NO_EM_RESTART': '1', 14:17:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:17:45 INFO - 'PWD': '/builds/slave/test', 14:17:45 INFO - 'SHELL': '/bin/bash', 14:17:45 INFO - 'SHLVL': '1', 14:17:45 INFO - 'TERM': 'linux', 14:17:45 INFO - 'TMOUT': '86400', 14:17:45 INFO - 'USER': 'cltbld', 14:17:45 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1466196116.115765-315994287', 14:17:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:45 INFO - '_': '/tools/buildbot/bin/python'} 14:17:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:45 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:17:45 INFO - Cleaning up... 14:17:45 INFO - Return code: 0 14:17:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:17:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f405f97df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a49a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a46d00>, '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 0x1a47ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a47f60>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1466196116.115765-315994287', '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 14:17:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:17:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:17:45 INFO - Using env: {'DISPLAY': ':0', 14:17:45 INFO - 'HOME': '/home/cltbld', 14:17:45 INFO - 'LANG': 'en_US.UTF-8', 14:17:45 INFO - 'LANGUAGE': 'en_US:en', 14:17:45 INFO - 'LOGNAME': 'cltbld', 14:17:45 INFO - 'MAIL': '/var/mail/cltbld', 14:17:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:45 INFO - 'MOZ_NO_REMOTE': '1', 14:17:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:45 INFO - 'NO_EM_RESTART': '1', 14:17:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:17:45 INFO - 'PWD': '/builds/slave/test', 14:17:45 INFO - 'SHELL': '/bin/bash', 14:17:45 INFO - 'SHLVL': '1', 14:17:45 INFO - 'TERM': 'linux', 14:17:45 INFO - 'TMOUT': '86400', 14:17:45 INFO - 'USER': 'cltbld', 14:17:45 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1466196116.115765-315994287', 14:17:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:45 INFO - '_': '/tools/buildbot/bin/python'} 14:17:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:45 INFO - Downloading/unpacking psutil>=3.1.1 14:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:17:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:17:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:17:47 INFO - Installing collected packages: psutil 14:17:47 INFO - Running setup.py install for psutil 14:17:47 INFO - building 'psutil._psutil_linux' extension 14:17:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:17:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:17:47 INFO - building 'psutil._psutil_posix' extension 14:17:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:17:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:17:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:17:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:17:48 INFO - Successfully installed psutil 14:17:48 INFO - Cleaning up... 14:17:48 INFO - Return code: 0 14:17:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:17:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f405f97df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a49a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a46d00>, '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 0x1a47ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a47f60>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1466196116.115765-315994287', '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 14:17:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:17:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:17:48 INFO - Using env: {'DISPLAY': ':0', 14:17:48 INFO - 'HOME': '/home/cltbld', 14:17:48 INFO - 'LANG': 'en_US.UTF-8', 14:17:48 INFO - 'LANGUAGE': 'en_US:en', 14:17:48 INFO - 'LOGNAME': 'cltbld', 14:17:48 INFO - 'MAIL': '/var/mail/cltbld', 14:17:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:48 INFO - 'MOZ_NO_REMOTE': '1', 14:17:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:48 INFO - 'NO_EM_RESTART': '1', 14:17:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:17:48 INFO - 'PWD': '/builds/slave/test', 14:17:48 INFO - 'SHELL': '/bin/bash', 14:17:48 INFO - 'SHLVL': '1', 14:17:48 INFO - 'TERM': 'linux', 14:17:48 INFO - 'TMOUT': '86400', 14:17:48 INFO - 'USER': 'cltbld', 14:17:48 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1466196116.115765-315994287', 14:17:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:48 INFO - '_': '/tools/buildbot/bin/python'} 14:17:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:17:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:17:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:17:50 INFO - Installing collected packages: mozsystemmonitor 14:17:50 INFO - Running setup.py install for mozsystemmonitor 14:17:50 INFO - Successfully installed mozsystemmonitor 14:17:50 INFO - Cleaning up... 14:17:50 INFO - Return code: 0 14:17:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:17: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')]} 14:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17: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')]} 14:17:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17: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', '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 0x7f405f97df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a49a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a46d00>, '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 0x1a47ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a47f60>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1466196116.115765-315994287', '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 14:17: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:17: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 jsonschema==2.5.1 14:17:50 INFO - Using env: {'DISPLAY': ':0', 14:17:50 INFO - 'HOME': '/home/cltbld', 14:17:50 INFO - 'LANG': 'en_US.UTF-8', 14:17:50 INFO - 'LANGUAGE': 'en_US:en', 14:17:50 INFO - 'LOGNAME': 'cltbld', 14:17:50 INFO - 'MAIL': '/var/mail/cltbld', 14:17:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:50 INFO - 'MOZ_NO_REMOTE': '1', 14:17:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:50 INFO - 'NO_EM_RESTART': '1', 14:17:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:17:50 INFO - 'PWD': '/builds/slave/test', 14:17:50 INFO - 'SHELL': '/bin/bash', 14:17:50 INFO - 'SHLVL': '1', 14:17:50 INFO - 'TERM': 'linux', 14:17:50 INFO - 'TMOUT': '86400', 14:17:50 INFO - 'USER': 'cltbld', 14:17:50 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1466196116.115765-315994287', 14:17:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:50 INFO - '_': '/tools/buildbot/bin/python'} 14:17:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:50 INFO - Downloading/unpacking jsonschema==2.5.1 14:17: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 14:17: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 14:17: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 14:17: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 14:17: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 14:17: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 14:17:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:17:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:17: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 14:17: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 14:17: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 14:17:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17: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 14:17: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 14:17:52 INFO - Downloading functools32-3.2.3-2.tar.gz 14:17:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:17:52 INFO - warning: no files found matching '*.txt' 14:17:52 INFO - no previously-included directories found matching 'build' 14:17:52 INFO - no previously-included directories found matching 'dist' 14:17:52 INFO - no previously-included directories found matching '.git*' 14:17:52 INFO - Installing collected packages: jsonschema, functools32 14:17:52 INFO - Running setup.py install for functools32 14:17:52 INFO - warning: no files found matching '*.txt' 14:17:52 INFO - no previously-included directories found matching 'build' 14:17:52 INFO - no previously-included directories found matching 'dist' 14:17:52 INFO - no previously-included directories found matching '.git*' 14:17:52 INFO - Successfully installed jsonschema functools32 14:17:52 INFO - Cleaning up... 14:17:53 INFO - Return code: 0 14:17:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:17:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:53 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 0x7f405f97df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a49a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a46d00>, '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 0x1a47ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a47f60>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1466196116.115765-315994287', '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 14:17:53 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 14:17:53 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 14:17:53 INFO - Using env: {'DISPLAY': ':0', 14:17:53 INFO - 'HOME': '/home/cltbld', 14:17:53 INFO - 'LANG': 'en_US.UTF-8', 14:17:53 INFO - 'LANGUAGE': 'en_US:en', 14:17:53 INFO - 'LOGNAME': 'cltbld', 14:17:53 INFO - 'MAIL': '/var/mail/cltbld', 14:17:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:53 INFO - 'MOZ_NO_REMOTE': '1', 14:17:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:53 INFO - 'NO_EM_RESTART': '1', 14:17:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:17:53 INFO - 'PWD': '/builds/slave/test', 14:17:53 INFO - 'SHELL': '/bin/bash', 14:17:53 INFO - 'SHLVL': '1', 14:17:53 INFO - 'TERM': 'linux', 14:17:53 INFO - 'TMOUT': '86400', 14:17:53 INFO - 'USER': 'cltbld', 14:17:53 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1466196116.115765-315994287', 14:17:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:53 INFO - '_': '/tools/buildbot/bin/python'} 14:17:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:53 INFO - Downloading/unpacking blobuploader==1.2.4 14:17: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 14:17: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 14:17:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17: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 14:17: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 14:17: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 14:17:55 INFO - Downloading blobuploader-1.2.4.tar.gz 14:17:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:17:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:17: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 14:17: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 14:17: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 14:17: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 14:17: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 14:17: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 14:17:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:17:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:17: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 14:17: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 14:17: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 14:17: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 14:17: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 14:17: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 14:17:55 INFO - Downloading docopt-0.6.1.tar.gz 14:17:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:17:55 INFO - Installing collected packages: blobuploader, requests, docopt 14:17:55 INFO - Running setup.py install for blobuploader 14:17:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:17:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:17:55 INFO - Running setup.py install for requests 14:17:56 INFO - Running setup.py install for docopt 14:17:56 INFO - Successfully installed blobuploader requests docopt 14:17:56 INFO - Cleaning up... 14:17:56 INFO - Return code: 0 14:17:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:17:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f405f97df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a49a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a46d00>, '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 0x1a47ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a47f60>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1466196116.115765-315994287', '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 14:17:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:17:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:17:56 INFO - Using env: {'DISPLAY': ':0', 14:17:56 INFO - 'HOME': '/home/cltbld', 14:17:56 INFO - 'LANG': 'en_US.UTF-8', 14:17:56 INFO - 'LANGUAGE': 'en_US:en', 14:17:56 INFO - 'LOGNAME': 'cltbld', 14:17:56 INFO - 'MAIL': '/var/mail/cltbld', 14:17:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:56 INFO - 'MOZ_NO_REMOTE': '1', 14:17:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:56 INFO - 'NO_EM_RESTART': '1', 14:17:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:17:56 INFO - 'PWD': '/builds/slave/test', 14:17:56 INFO - 'SHELL': '/bin/bash', 14:17:56 INFO - 'SHLVL': '1', 14:17:56 INFO - 'TERM': 'linux', 14:17:56 INFO - 'TMOUT': '86400', 14:17:56 INFO - 'USER': 'cltbld', 14:17:56 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1466196116.115765-315994287', 14:17:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:56 INFO - '_': '/tools/buildbot/bin/python'} 14:17:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:17:56 INFO - Running setup.py (path:/tmp/pip-ccO_zH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:17:56 INFO - Running setup.py (path:/tmp/pip-PLrGMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:17:56 INFO - Running setup.py (path:/tmp/pip-gkDsW5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:17:56 INFO - Running setup.py (path:/tmp/pip-DGWOwE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:17:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:17:56 INFO - Running setup.py (path:/tmp/pip-hVPTdP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:17:57 INFO - Running setup.py (path:/tmp/pip-XNZVRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:17:57 INFO - Running setup.py (path:/tmp/pip-mNVVDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:17:57 INFO - Running setup.py (path:/tmp/pip-qzR02N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:17:57 INFO - Running setup.py (path:/tmp/pip-mtuq3e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:17:57 INFO - Running setup.py (path:/tmp/pip-MvreKS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:17:57 INFO - Running setup.py (path:/tmp/pip-9RonHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:17:57 INFO - Running setup.py (path:/tmp/pip-sMCAEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:17:57 INFO - Running setup.py (path:/tmp/pip-ML0CPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:17:57 INFO - Running setup.py (path:/tmp/pip-puBH1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:17:57 INFO - Running setup.py (path:/tmp/pip-wl3HVd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:17:57 INFO - Running setup.py (path:/tmp/pip-_Av3Tz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:17:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:17:57 INFO - Running setup.py (path:/tmp/pip-kZV1lT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:17:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:17:57 INFO - Running setup.py install for manifestparser 14:17:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:17:57 INFO - Running setup.py install for mozcrash 14:17:58 INFO - Running setup.py install for mozdebug 14:17:58 INFO - Running setup.py install for mozdevice 14:17:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:17:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:17:58 INFO - Running setup.py install for mozfile 14:17:58 INFO - Running setup.py install for mozhttpd 14:17:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:17:58 INFO - Running setup.py install for mozinfo 14:17:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:17:58 INFO - Running setup.py install for mozInstall 14:17:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:17:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:17:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:17:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:17:58 INFO - Running setup.py install for mozleak 14:17:58 INFO - Running setup.py install for mozlog 14:17:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:17:58 INFO - Running setup.py install for moznetwork 14:17:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:17:59 INFO - Running setup.py install for mozprocess 14:17:59 INFO - Running setup.py install for mozprofile 14:17:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:17:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:17:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:17:59 INFO - Running setup.py install for mozrunner 14:17:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:17:59 INFO - Running setup.py install for mozscreenshot 14:17:59 INFO - Running setup.py install for moztest 14:17:59 INFO - Running setup.py install for mozversion 14:17:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:17:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:17:59 INFO - Cleaning up... 14:17:59 INFO - Return code: 0 14:17:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:17:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f405f97df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a49a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a46d00>, '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 0x1a47ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a47f60>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1466196116.115765-315994287', '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 14:17:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:17:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:17:59 INFO - Using env: {'DISPLAY': ':0', 14:17:59 INFO - 'HOME': '/home/cltbld', 14:17:59 INFO - 'LANG': 'en_US.UTF-8', 14:17:59 INFO - 'LANGUAGE': 'en_US:en', 14:17:59 INFO - 'LOGNAME': 'cltbld', 14:17:59 INFO - 'MAIL': '/var/mail/cltbld', 14:17:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:59 INFO - 'MOZ_NO_REMOTE': '1', 14:17:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:59 INFO - 'NO_EM_RESTART': '1', 14:17:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:17:59 INFO - 'PWD': '/builds/slave/test', 14:17:59 INFO - 'SHELL': '/bin/bash', 14:17:59 INFO - 'SHLVL': '1', 14:17:59 INFO - 'TERM': 'linux', 14:17:59 INFO - 'TMOUT': '86400', 14:17:59 INFO - 'USER': 'cltbld', 14:17:59 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1466196116.115765-315994287', 14:17:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:59 INFO - '_': '/tools/buildbot/bin/python'} 14:17:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:17:59 INFO - Running setup.py (path:/tmp/pip-tQ_Xu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:17:59 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:17:59 INFO - Running setup.py (path:/tmp/pip-aIBNMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:18:00 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)) 14:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:18:00 INFO - Running setup.py (path:/tmp/pip-3LV8t2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:18:00 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)) 14:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:18:00 INFO - Running setup.py (path:/tmp/pip-StfmRJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:18:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:18:00 INFO - Running setup.py (path:/tmp/pip-c0mi1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:18:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:18:00 INFO - Running setup.py (path:/tmp/pip-SXuzWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:18:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:18:00 INFO - Running setup.py (path:/tmp/pip-B7aAiT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:18:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:18:00 INFO - Running setup.py (path:/tmp/pip-jGoYgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:18:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:18:00 INFO - Running setup.py (path:/tmp/pip-BftYUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:18:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:18:00 INFO - Running setup.py (path:/tmp/pip-R6QtLD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:18:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:18:00 INFO - Running setup.py (path:/tmp/pip-CWEvS2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:18:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:18:00 INFO - Running setup.py (path:/tmp/pip-95KauI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:18:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:18:00 INFO - Running setup.py (path:/tmp/pip-qoWCxU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:18:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:18:00 INFO - Running setup.py (path:/tmp/pip-8C8aKF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:18:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:18:00 INFO - Running setup.py (path:/tmp/pip-T5RkPs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:18:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:18:00 INFO - Running setup.py (path:/tmp/pip-npFfGJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:18:01 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)) 14:18:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:18:01 INFO - Running setup.py (path:/tmp/pip-C9d2Ws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:18:01 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)) 14:18:01 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)) 14:18:01 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)) 14:18:01 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)) 14:18:01 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)) 14:18:01 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)) 14:18:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:18:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:03 INFO - Downloading blessings-1.6.tar.gz 14:18:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:18:03 INFO - Installing collected packages: blessings 14:18:03 INFO - Running setup.py install for blessings 14:18:03 INFO - Successfully installed blessings 14:18:03 INFO - Cleaning up... 14:18:03 INFO - Return code: 0 14:18:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:18:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:18:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:18:03 INFO - Reading from file tmpfile_stdout 14:18:03 INFO - Current package versions: 14:18:03 INFO - argparse == 1.2.1 14:18:03 INFO - blessings == 1.6 14:18:03 INFO - blobuploader == 1.2.4 14:18:03 INFO - docopt == 0.6.1 14:18:03 INFO - functools32 == 3.2.3-2 14:18:03 INFO - jsonschema == 2.5.1 14:18:03 INFO - manifestparser == 1.1 14:18:03 INFO - mozInstall == 1.12 14:18:03 INFO - mozcrash == 0.17 14:18:03 INFO - mozdebug == 0.1 14:18:03 INFO - mozdevice == 0.48 14:18:03 INFO - mozfile == 1.2 14:18:03 INFO - mozhttpd == 0.7 14:18:03 INFO - mozinfo == 0.9 14:18:03 INFO - mozleak == 0.1 14:18:03 INFO - mozlog == 3.2 14:18:03 INFO - moznetwork == 0.27 14:18:03 INFO - mozprocess == 0.22 14:18:03 INFO - mozprofile == 0.28 14:18:03 INFO - mozrunner == 6.11 14:18:03 INFO - mozscreenshot == 0.1 14:18:03 INFO - mozsystemmonitor == 0.3 14:18:03 INFO - moztest == 0.7 14:18:03 INFO - mozversion == 1.4 14:18:03 INFO - psutil == 3.1.1 14:18:03 INFO - requests == 1.2.3 14:18:03 INFO - wsgiref == 0.1.2 14:18:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:18:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f405f97df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a49a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a46d00>, '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 0x1a47ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a47f60>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1466196116.115765-315994287', '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 14:18:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:18:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:18:03 INFO - Using env: {'DISPLAY': ':0', 14:18:03 INFO - 'HOME': '/home/cltbld', 14:18:03 INFO - 'LANG': 'en_US.UTF-8', 14:18:03 INFO - 'LANGUAGE': 'en_US:en', 14:18:03 INFO - 'LOGNAME': 'cltbld', 14:18:03 INFO - 'MAIL': '/var/mail/cltbld', 14:18:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:03 INFO - 'MOZ_NO_REMOTE': '1', 14:18:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:03 INFO - 'NO_EM_RESTART': '1', 14:18:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:03 INFO - 'PWD': '/builds/slave/test', 14:18:03 INFO - 'SHELL': '/bin/bash', 14:18:03 INFO - 'SHLVL': '1', 14:18:03 INFO - 'TERM': 'linux', 14:18:03 INFO - 'TMOUT': '86400', 14:18:03 INFO - 'USER': 'cltbld', 14:18:03 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1466196116.115765-315994287', 14:18:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:03 INFO - '_': '/tools/buildbot/bin/python'} 14:18:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:18:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:18:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:18:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:18:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:18:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:18:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:18:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:18:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:18:03 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:18:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:18:03 INFO - Cleaning up... 14:18:03 INFO - Return code: 0 14:18:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:18:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f405f97df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a49a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a46d00>, '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 0x1a47ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a47f60>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1466196116.115765-315994287', '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 14:18:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:18:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:18:03 INFO - Using env: {'DISPLAY': ':0', 14:18:03 INFO - 'HOME': '/home/cltbld', 14:18:03 INFO - 'LANG': 'en_US.UTF-8', 14:18:03 INFO - 'LANGUAGE': 'en_US:en', 14:18:03 INFO - 'LOGNAME': 'cltbld', 14:18:03 INFO - 'MAIL': '/var/mail/cltbld', 14:18:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:03 INFO - 'MOZ_NO_REMOTE': '1', 14:18:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:03 INFO - 'NO_EM_RESTART': '1', 14:18:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:03 INFO - 'PWD': '/builds/slave/test', 14:18:03 INFO - 'SHELL': '/bin/bash', 14:18:03 INFO - 'SHLVL': '1', 14:18:03 INFO - 'TERM': 'linux', 14:18:03 INFO - 'TMOUT': '86400', 14:18:03 INFO - 'USER': 'cltbld', 14:18:03 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1466196116.115765-315994287', 14:18:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:03 INFO - '_': '/tools/buildbot/bin/python'} 14:18:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:18:03 INFO - Cleaning up... 14:18:03 INFO - Return code: 0 14:18:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:18:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f405f97df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a49a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a46d00>, '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 0x1a47ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a47f60>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1466196116.115765-315994287', '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 14:18:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:18:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:18:03 INFO - Using env: {'DISPLAY': ':0', 14:18:03 INFO - 'HOME': '/home/cltbld', 14:18:03 INFO - 'LANG': 'en_US.UTF-8', 14:18:03 INFO - 'LANGUAGE': 'en_US:en', 14:18:03 INFO - 'LOGNAME': 'cltbld', 14:18:03 INFO - 'MAIL': '/var/mail/cltbld', 14:18:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:03 INFO - 'MOZ_NO_REMOTE': '1', 14:18:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:03 INFO - 'NO_EM_RESTART': '1', 14:18:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:03 INFO - 'PWD': '/builds/slave/test', 14:18:03 INFO - 'SHELL': '/bin/bash', 14:18:03 INFO - 'SHLVL': '1', 14:18:03 INFO - 'TERM': 'linux', 14:18:03 INFO - 'TMOUT': '86400', 14:18:03 INFO - 'USER': 'cltbld', 14:18:03 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1466196116.115765-315994287', 14:18:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:03 INFO - '_': '/tools/buildbot/bin/python'} 14:18:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:04 INFO - Downloading/unpacking flake8 14:18:04 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 14:18:04 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 14:18:04 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 14:18:04 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 14:18:04 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 14:18:04 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 14:18:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:18:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:18: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 14:18: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 14:18: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 14:18: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 14:18: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 14:18: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 14:18:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:18:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:18: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 14:18: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 14:18: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 14:18: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 14:18: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 14:18: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 14:18:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:18: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 14:18: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 14:18: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 14:18: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 14:18: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 14:18: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 14:18:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:18:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:18:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:18:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:18:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:18:06 INFO - no previously-included directories found matching 'docs/_build' 14:18:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:18:06 INFO - Running setup.py install for pep8 14:18:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:18:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:18:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:18:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:18:06 INFO - no previously-included directories found matching 'docs/_build' 14:18:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:18:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:18:06 INFO - Cleaning up... 14:18:07 INFO - Return code: 0 14:18:07 INFO - Running post-action listener: _resource_record_post_action 14:18:07 INFO - Running post-action listener: _start_resource_monitoring 14:18:07 INFO - Starting resource monitoring. 14:18:07 INFO - ##### 14:18:07 INFO - ##### Finished create-virtualenv step (success) 14:18:07 INFO - ##### 14:18:07 INFO - ##### 14:18:07 INFO - ##### Running install step. 14:18:07 INFO - ##### 14:18:07 INFO - Running pre-action listener: _resource_record_pre_action 14:18:07 INFO - Running main action method: install 14:18:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:18:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:18:07 INFO - Reading from file tmpfile_stdout 14:18:07 INFO - Detecting whether we're running mozinstall >=1.0... 14:18:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:18:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:18:07 INFO - Reading from file tmpfile_stdout 14:18:07 INFO - Output received: 14:18:07 INFO - Usage: mozinstall [options] installer 14:18:07 INFO - Options: 14:18:07 INFO - -h, --help show this help message and exit 14:18:07 INFO - -d DEST, --destination=DEST 14:18:07 INFO - Directory to install application into. [default: 14:18:07 INFO - "/builds/slave/test"] 14:18:07 INFO - --app=APP Application being installed. [default: firefox] 14:18:07 INFO - mkdir: /builds/slave/test/build/application 14:18:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:18:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:18:24 INFO - Reading from file tmpfile_stdout 14:18:24 INFO - Output received: 14:18:24 INFO - /builds/slave/test/build/application/firefox/firefox 14:18:24 INFO - Running post-action listener: _resource_record_post_action 14:18:24 INFO - ##### 14:18:24 INFO - ##### Finished install step (success) 14:18:24 INFO - ##### 14:18:24 INFO - ##### 14:18:24 INFO - ##### Running run-tests step. 14:18:24 INFO - ##### 14:18:24 INFO - Running pre-action listener: _resource_record_pre_action 14:18:24 INFO - Running main action method: run_tests 14:18:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:18:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:18:24 INFO - Python 2.7.3 14:18:24 INFO - Return code: 0 14:18:24 INFO - grabbing minidump binary from tooltool 14:18:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:24 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 0x1a46d00>, '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 0x1a47ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a47f60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:18:24 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 14:18:24 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 14:18:24 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 14:18:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:18:24 INFO - Return code: 0 14:18:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:18:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:18:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:18:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:18:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:18:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:18:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:18:25 INFO - Return code: 0 14:18:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 14:18:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --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 14:18:25 INFO - Using env: {'DISPLAY': ':0', 14:18:25 INFO - 'HOME': '/home/cltbld', 14:18:25 INFO - 'LANG': 'en_US.UTF-8', 14:18:25 INFO - 'LANGUAGE': 'en_US:en', 14:18:25 INFO - 'LOGNAME': 'cltbld', 14:18:25 INFO - 'MAIL': '/var/mail/cltbld', 14:18:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:18:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:18:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:25 INFO - 'MOZ_NO_REMOTE': '1', 14:18:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:18:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:25 INFO - 'NO_EM_RESTART': '1', 14:18:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:25 INFO - 'PWD': '/builds/slave/test', 14:18:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:18:25 INFO - 'SHELL': '/bin/bash', 14:18:25 INFO - 'SHLVL': '1', 14:18:25 INFO - 'TERM': 'linux', 14:18:25 INFO - 'TMOUT': '86400', 14:18:25 INFO - 'USER': 'cltbld', 14:18:25 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1466196116.115765-315994287', 14:18:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:25 INFO - '_': '/tools/buildbot/bin/python'} 14:18:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 14:18:25 INFO - mozversion application_buildid: 20160617113028 14:18:25 INFO - mozversion application_changeset: 530e96008b7e987c75ddbab59cabdc11f9bbabb9 14:18:25 INFO - mozversion application_display_name: Nightly 14:18:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:18:25 INFO - mozversion application_name: Firefox 14:18:25 INFO - mozversion application_remotingname: firefox 14:18:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:18:25 INFO - mozversion application_vendor: Mozilla 14:18:25 INFO - mozversion application_version: 50.0a1 14:18:25 INFO - mozversion platform_buildid: 20160617113028 14:18:25 INFO - mozversion platform_changeset: 530e96008b7e987c75ddbab59cabdc11f9bbabb9 14:18:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:18:25 INFO - mozversion platform_version: 50.0a1 14:18:25 INFO - using testdate: 1466198305 14:18:25 INFO - actual date: 1466198305 14:18:25 INFO - starting webserver on 'localhost:58773' 14:18:25 INFO - SUITE-START | Running 2 tests 14:18:25 INFO - TEST-START | dromaeo_css 14:18:25 INFO - operating with platform_type : linux_ 14:18:25 INFO - Initialising browser for dromaeo_css test... 14:18:25 INFO - TEST-INFO | started process 6752 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmph6nA1I/profile http://localhost:58773/getInfo.html) 14:18:30 INFO - PROCESS | 6752 | __metrics Screen width/height:1600/1200 14:18:30 INFO - PROCESS | 6752 | colorDepth:24 14:18:30 INFO - PROCESS | 6752 | Browser inner width/height: 1024/697 14:18:30 INFO - PROCESS | 6752 | __metrics 14:18:30 ERROR - PROCESS | 6752 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 14:18:31 INFO - TEST-INFO | 6752: exit 0 14:18:31 INFO - Browser initialized. 14:18:31 INFO - Running cycle 1/1 for dromaeo_css test... 14:18:31 INFO - TEST-INFO | started process 6872 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmph6nA1I/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:18:43 INFO - PROCESS | 6872 | RSS: Main: 184893440 14:18:43 INFO - PROCESS | 6872 | 14:19:33 INFO - PROCESS | 6872 | 1466198373171 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] 14:21:41 INFO - PROCESS | 6872 | Cycle 1(1): loaded http://localhost:58773/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58773/tests/dromaeo/cssquery-ext.html) 14:21:42 INFO - PROCESS | 6872 | RSS: Main: 189149184 14:21:42 INFO - PROCESS | 6872 | 14:24:44 INFO - PROCESS | 6872 | Cycle 1(1): loaded http://localhost:58773/tests/dromaeo/cssquery-ext.html (next: http://localhost:58773/tests/dromaeo/cssquery-jquery.html) 14:24:45 INFO - PROCESS | 6872 | RSS: Main: 187834368 14:24:45 INFO - PROCESS | 6872 | 14:27:47 INFO - PROCESS | 6872 | Cycle 1(1): loaded http://localhost:58773/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58773/tests/dromaeo/cssquery-mootools.html) 14:27:47 INFO - PROCESS | 6872 | RSS: Main: 188583936 14:27:47 INFO - PROCESS | 6872 | 14:30:49 INFO - PROCESS | 6872 | Cycle 1(1): loaded http://localhost:58773/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58773/tests/dromaeo/cssquery-prototype.html) 14:30:49 INFO - PROCESS | 6872 | RSS: Main: 185982976 14:30:49 INFO - PROCESS | 6872 | 14:33:52 INFO - PROCESS | 6872 | Cycle 1(1): loaded http://localhost:58773/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58773/tests/dromaeo/cssquery-yui.html) 14:33:52 INFO - PROCESS | 6872 | RSS: Main: 188039168 14:33:52 INFO - PROCESS | 6872 | 14:36:55 INFO - PROCESS | 6872 | Cycle 1(1): loaded http://localhost:58773/tests/dromaeo/cssquery-yui.html (next: http://localhost:58773/tests/dromaeo/cssquery-dojo.html) 14:36:55 INFO - PROCESS | 6872 | RSS: Main: 188862464 14:36:55 INFO - PROCESS | 6872 | 14:36:55 INFO - PROCESS | 6872 | __start_tp_report 14:36:55 INFO - PROCESS | 6872 | _x_x_mozilla_page_load 14:36:55 INFO - PROCESS | 6872 | _x_x_mozilla_page_load_details 14:36:55 INFO - PROCESS | 6872 | |i|pagename|runs| 14:36:55 INFO - PROCESS | 6872 | |0;dojo.html;3108.782385233034;3145.2294187923962;3171.0645359618916;3180.570622965899;3189.489681650935;5370.43610420906;5403.378611459683;5429.131338985763;5457.317835270591;5482.780688772445;5313.442088580701;5332.14685650296;5360.812371566996;5373.704446255454;5396.676199428037;4860.684055536379;4861.076395484864;4942.209246520558;4997.425296090942;5034.11902916988;4861.927071093936;5090.160123579605;5114.207297868837;5115.258287548303;5123.205903085028;4820.493848145947;4863.17326054568;4882.218844984804;4909.116359055369;4909.386326709161;4904.485029071968;4915.680480768774;4917.164082106051;4923.805385318487;4983.8504844854715;4893.608511319086;4895.828645997373;4903.730294833783;4906.484819093979;4932.654714170009;5230.843074707726;5299.364076310867;5300.734963251861;5364.195370694388;5391.595630327741;5707.600467967244;5744.6840423776675;5747.885042299131;5753.223314852525;5754.568407369422;5551.8889622207325;5785.27684039495;5793.391693872167;5794.275715535558;5796.739146738365;5408.4591540845995;5452.781888724447;5456.263404440389;5463.590230732711;5468.589855760794;5890.970545147246;5943.524518038546;5959.165716799652;5961.552883533665;5977.581569290195;5510.256115424367;5564.805231816867;5730.283714535683;5732.799352022659;5745.540356771448;5611.523020543218;5712.971435142881;5717.199592057115;5720.856978575569;5765.1928729977835;5608.355039170466;5683.119116536944;5691.772329106872;5700.743466544015;5705.22979397776;5536.86157846049;5760.769569217268;5761.654300741969;5762.942370576325;5770.19217309577;4401.933970990438;4447.844325448594;4451.087527056946;4490.865274041784;4491.416115904912;3944.1914407546383;3963.564007959122;3991.960080399217;4003.5195776506425;4007;5406.648567843156;5438.320209973754;5477.698726570077;5580.135079062752;5623.437656234426;5734.799282025109;5756.625819321815;5761.251037365199;5766.538676905838;5836.562257830679;5493.423190565013;5518.503334699896;5519.834404967857;5523.475269849358;5526.171074338801;4896.706197628082;4917.1149193145575;4937.259411088294;4962.925556116661;4963.880545143055;5853.09277062056;5862.091375836752;5862.413758624189;5886.087656413177;5951.375105613848;5779.450952159454;5783.8554036149435;5788.450097240755;5796.391378905154;5799.420057994167;5828.154917537018;5859.648421094748;5866;5887.4406931341455;5911.733971971185;5551.555875529867;5581.860453488695;5588.636738611977;5602.859928501657;5607.43925607436;5650.547956163579;5678.971605141948;5697.487226149667;5704.172894930295;5705.914411283917;5550.222968784454;5623.8875222496135;5630.690312032878;5694.971525142348;5707.942920570741;5543.916841247304;5629.521490673174;5643.322801263875;5687.7724891005555;5705.429457054262;5488.094464413327;5514.255575497256;5550.500454959073;5553.916691249554;5556.138798486241;5585.1901474286815;5610.887782244251;5638.830835074954;5734.512566431733;5735.082386818089;5523.502884740232;5594.02104631696;5595.300587426572;5603.80386686464;5624.943750562606 14:36:55 INFO - PROCESS | 6872 | |1;ext.html;575.6488541989386;616.5529990756701;617.0959544267647;636.2015670333732;648.186525909983;37389;41263.38104928428;41305.58694413055;41340.79329603352;41382;41885.581144188625;41921.79039104808;42288.154236915245;42413.78793106038;42537.7873110634;8745.300375969939;8906.198442140207;8934.285257179443;8950.14973577509;8962.955185224066;8777.166169213915;8793.692220772275;8798.252148567379;8916.286697064219;8921.732348029569;8792.120787921189;8897.95551022244;8930.151635594608;8935.240504557121;8944;8854.911450885505;8895.332850036208;8895.822083558358;8925.196732294093;8936.240419564345;8712.56437178145;8804.779880502974;8824.382293239476;8835.602397892111;8859.55702214893;40254;40708;40772;40782.59217407818;40833;3015.276333679901;3406.6423025582453;3435.278591495789;3455.6544345565494;3542.3092496963104;30398.088057358316;30475.23811904698;31168.53247201294;31293.84353078243;31342.21644458884;3574.8927532174075;3637.527121474218;3639.5996440391536;3657.085728567858;3833.884983450501;303628;305218;305520;306031;306405;33838.32323353519;34188;34310;34423.65576344255;34429.48355774665;34565.82717086399;36211.094722632144;36291.63708362936;36355.091122722144;36359.27281454356;15628.2185890705;15797.052176869425;15815.68368632644;15864.365425383086;15874.841251587568;12951.740965180832;13049.804252936214;13053;13068.607941761762;13081.934590326988;8138.959305203436;8187.38594605407;8190.7542773715695;8242.093369729326;8309.04445988719;3196.360727854392;3196.6164060312913;3218.211538173116;3226.8063916165106;3229.128135403475;957.157014586436;963.5037955452947;969.4571040217501;1002.4737013068197;1018.6078359831519;32184.83907580447;32457;32458.188545286557;32576.67423325784;32671.509927351108;1038.0087016898844;1061;1070.8875568065396;1166.0613206368785;1221.6457227403953;16181;16248.75626865598;16344.83655163457;16359.918200408922;16501.33994640201;515455;515976;519504;521704;523563;54554.18168727472;55118.44881551133;55241.723791380784;55264.44735552593;55472.16791748127;1302.446460254388;1334.0461569977513;1364.7884577890443;1382.2881216173678;1383.584924522639;26985.325366865985;27767.444651107267;28319.858400707864;28322.85838570794;28415;40219.798901005306;40376.79811600923;40693.79653101716;41721.37417938794;41857.16285674331;368652;368779;370896;371343;372358;27157;27282.590761138203;27575.724242757315;27823.165305040882;27860.16419507418;45949.310760337954;46117.76941115273;46286;46471;47388.289175663085;40167.3974890371;40192.39711404273;40250.396244056945;40517;40852.77441676754;39524.40713389359;40602.1879562413;40604;40638.39042414425;40943.590564093975;35121.473177902866;39066.80466597649;39148.412773807846;39347.213055739296;40294.59705402909;31699.52450713195;36031.45952810658;36061.32240142808;36276.81861590675;36504.63495365012;27186;27502.44995100127;27706.44587108287;27779.583306250828;27790 14:36:55 INFO - PROCESS | 6872 | |2;jquery.html;372.3725522494595;380.1086452269428;385.2410750820882;388.3921662598034;402.830811059355;17569;19727.40817775467;20121.094550745216;20355.694664580005;20393.184272629096;18473.168707408164;18850.245990160412;19022.478201743863;19207.135678894447;19272.22911083555;5618.2415373924505;5669.659820410789;5759.769609215627;5780.826575202751;5795.71021448928;5635.943640563603;5640.379558248589;5663.2637757091725;5668.149777533362;5679.091345384739;5277.86805329866;5554.583406244527;5558.499735023867;5701.087825947829;5718.313802343704;5613.522850557708;5619.943800562003;5666.093425051992;5694.345150307726;5716.742746576414;5415.783368665248;5543.417941116206;5547.278853748987;5550.111982082847;5565.666060036411;12410.627681169579;12600.306983115925;19458.610827783366;22582;22954.08183672651;2350.612148995414;2660.3349162709324;2751.1333929812045;2873.7126287371307;2896.6668833084045;9219.723408297761;9514.191293740041;9538.284628652878;11267.436628168642;14126.293685315693;1825.954351141219;1848.7596612440432;1877.2678655324435;1942.77658069321;1952.1313015708015;77179.22820771777;78444;79032.60483697544;79083.60458197672;80559;10612.946935265274;10646.095081918123;10721.946390268155;10788;11074.667759967213;15032.098074115587;15261.847381526264;15287.159206243541;15312;15315.61710957235;7789.1042530108625;8353.791155221168;8422.24199822019;8438.367122465717;8489.660413583511;8079.798005049921;8130.959345203236;8134;8256.958715206505;8340.082590914995;4314.568543145723;4371.912561748747;4705.811767529329;4710.62315014798;4852.344933433941;1769.6726105670234;1878.3707458001722;1910.2168111074393;1949.3274820187012;1982.732331135307;933.453929451265;961.6874515782399;963.4171326347599;1002.6139936124499;1003.9096481316717;18505.629887402447;19232.134553944827;19302.16629420231;19480.610387792163;19961.20155193776;953.5756588318131;955.8088382323563;986.2159583131428;1018.5009345420691;1031.9535620897077;10285.125764309967;10882.401467919182;10979.341239525655;11055.170862185369;11151.665450036511;353946;361877;478004;481054;493039;80304;96722;99561;100496.49751751195;101546.49226753818;973.5910917414703;1004.8090862735911;1035.53918506264;1039.2413538117216;1046.3094357723867;17886.731699024265;18121.093945302946;18131.728024079912;18365.449036528924;18610.069496524848;29432;32422.513662295558;40082;41457.37813932854;43092.08236803198;57708.71145644413;58781.41218587759;59235.703821480616;59958.40041599703;60152.69923650354;8088.029436467662;8238.382121341043;8249.628766705393;8552.786180345542;8590.527520986405;12241.755164896475;13548.932255338661;13643.727125457634;13902.860971390157;13903.721925561635;11963.342016188844;11987.400629968291;12232.388380581113;12272.263664180178;12394.504219831466;12050.698732531406;12055.336956467478;12136.635900922987;12193.390330483262;12316.261024338568;11334.263272887236;11926.344051077274;12129.090318226345;12165.878341216474;12233.571824986082;7731.961340193263;7975.880361794461;8186.2632363087605;8441.029281632691;8938.821223575622;11806.82289765637;12084.093692972887;12233;12319.63041108768;12507 14:36:55 INFO - PROCESS | 6872 | |3;mootools.html;1429.128231778615;1435.7559214933462;1544.9227538623065;1658.2537857963919;1666.2834980958182;7307;7845.568493732842;7848.2544158304945;8367.121452247518;8368.707095251668;7859.214078592138;8037.799055023627;8105.230003149706;8127.268545830874;8166.877496837537;2245.191730976851;2254.5265494246228;2263.4341414646337;2277.339571524256;2291.4271432141963;2171.7502487213937;2199.967000494994;2215.401841502793;2235.9217427390045;2250.6849041134174;2215.324326080545;2226.476777957179;2226.92205772798;2228.2980861028805;2254.0870947266385;2169.3600387885613;2178.4336072621154;2180.0952604669124;2192;2193.024104273599;2192.1012384922105;2201.6037113319594;2201.7798220178015;2205.1730601024615;2210.3700445372992;8241.464304820227;8247.917520824834;8293.087760346358;8337.124601916832;8350.373721970876;4890.315355850148;4963.354763880672;4971.801127954877;4973.204287314013;5002.9499705002845;3118.984405077983;3170.8414579270943;3258.771885967983;3336.7831090979007;3341.398548261312;969.3795970578835;974.7514383832078;983.1201075037801;1019.5208252121491;1021.8671572695501;11348.716282092932;11417.086633069335;11430.37132957687;11495.310281383145;11495.827562586568;4428.446444194476;4449.488308844459;4450.421445212101;4454.866354009385;4457.888552786207;9653.951730241444;9679.70960871175;9680.031996800264;9709;9743.123118919331;4986.4514903360605;5025.874353141127;5032.0690672225755;5040.344755181803;5041.521055499722;4190.350495673176;4555.134524440412;4668.603168730696;4672.135654903854;4724.740139292372;3798.2973149967343;3804.752691075071;3823.808809559511;3874.643874643852;3882.6311500407414;1224.1736827641307;1226.3806777577267;1232.2729589542214;1246.1401632873287;1248.7877060899668;886.1271647427279;933.9112784285481;957.7892863570004;966.9274804389698;985.4678473624163;5577.024020796344;5733.111367738007;5778.508826749773;5806.564507661942;5889.411058894077;911.0479548871446;932.7061975477839;939.6617217801586;956.5552018311519;989.618996686281;3963.1083006323925;4095.2219078375015;4148.896277593084;4155.335146376626;4184.602462766033;10051;10195.286329956833;10271.589136434608;10338.741531461774;10380;10178.949105254575;10302.845457318146;10305.948470257601;10310.948445257725;10325.74185645365;7386.446016548673;7503.437242206747;7583.393328533593;7586.582737949356;7589.734359297398;5557.916631250615;5694.886102278014;5850.64896106235;5862.120681897579;5874.265716785402;9352.859707104535;9480.478573678514;9515.143637072697;9566.856497152687;9597.32818702712;9226.907730922605;9590.568424421057;9600.75998100053;9610.567524461276;9649.276304277348;6480.384363485461;6903.275156108536;6962.965185174245;7145.3926416253125;7166.605836678824;8292.917070829215;8306.377021723274;8330.083690793886;8376;8413.45312554682;7272.672729727281;7453.068366454193;7536.472446928662;7541.811454713676;7558.2441755823975;7239.746608868664;7323.63381830917;7355.7057717690695;7456.217097204715;7502.324790768857;6769.593824370553;6772.356626120511;6803.421709154777;6805.829854253485;6830.624315662488;4831.95168048315;4945.357103576512;5075.974620126875;5124.052050370693;5214.843554693365;5014.07239660664;5099.6685215460875;5145.279660847559;5173.92239116406;5231.529162375405 14:36:55 INFO - PROCESS | 6872 | |4;prototype.html;289.5931216640619;302.1871166561948;304.4869395069307;305.26735833998407;309.6037072547139;5488.204210389491;5519.227308176848;5669.518090962268;5724.7996320128805;5726.255586773714;5599.972000139994;5617.022977821761;5620.775168993236;5629.746661400237;5646.096624540074;4276;4306.892327691801;4332.458442694663;4354.390385346054;4365.039691267916;4074.5925407459167;4287.142571485715;4291.249031419505;4354.80403381847;4385.736855788647;4208.473940757405;4218.578142185772;4260.36094585813;4261.616454519092;4280.807363668642;4269.1675123351115;4277;4292.7424354538825;4303.483581970152;4305.741655500648;3519.3137338219058;3729.850805967785;3742.4947632069593;3746.4942232798494;3750.3999360102252;5471.288732464794;5474.178873169017;5481.424450432727;5493.670379777186;5507.862303442406;4857.514248575149;4870.464248932614;4879.756012199411;4885.2916327132725;4916.410030796327;5545.417731138213;5846.924341858621;5885.676287804169;5892.469677729025;5895.41045895407;4061.208064427438;4062.2484840304637;4063.573324800883;4067.5763482781085;4075.205334959684;6136.785212517585;6164.7534098636;6176.227971503562;6188.504919606421;6195.101710252034;4052.4124002019544;4116.464859568297;4133.483314585676;4164.541900390955;4170.249355116108;4151.6886233532605;4156.584341565819;4179;4194.958050419517;4195.643370313496;4848.127337079289;4859.465458799529;4870.707757534488;4894;4921.606271498343;5662.669272720907;5902.291724993029;5935.60513279379;5992.490638295706;6006.399360064046;1427.2578259305103;1446.0383844743337;1446.2551785830306;1449.8039117727706;1456.7523521001456;867.7830542364409;901.963921443148;905.1672461335587;929.4516235420999;931.0689310689311;5054.368203974504;5082.491750824888;5098.388193416814;5112.463191364927;5129.820456284012;5456.590755693339;5474.742528195718;5479.75341109651;5497.587680923947;5527.861803454945;5039.7228152451235;5194.168932970707;5218.217267409843;5308.654937429054;5774.82675519735;3186.713195812388;3200.7439404848024;3208.6149662040702;3215.3569286142865;3225.9838700806813;6111.877762444727;6244.750209991549;6265;6344.382182543422;6355.968220158869;6058.697380063308;6118.1434599156155;6159.753609855646;6175.011998080286;6194.81415557534;6087.573869829158;6202.666426718277;6312.589681670676;6313.494920406449;6317.399847014526;5839.620424672553;5942.821715348547;5992.520598352208;6053.424924632153;6148.754049837957;5937.643741375531;5960.195373624505;5960.8807823844145;5964.850878728066;6043.425874541911;6048.758049677964;6221.346758590464;6233.96883015582;6341.651209183355;6368.649724265025;4154.688398370195;4154.771487568213;4195.685323600803;4196.349565817303;4204.222218889515;6076.422739839708;6100.145979562776;6107.144999699956;6131.325554189125;6190.442860142609;5770.5095066919785;5942.970285148546;5944.554158438221;5959.4934430573885;5963.896679114378;5827.76688932438;5896.850114227685;5921.792737254175;5944.910826337695;5955.612885162451;5443.346798384061;5726.513246374105;5794.536437084938;5808.883822323445;5819.912701309569;5864.794732184353;5880.529557635294;5888.440598143341;5905.675187864708;5917.556183286185;5749.798757043483;5771.307443106854;5774.220480235114;5795.884082318415;5860.531157507475 14:36:55 INFO - PROCESS | 6872 | |5;yui.html;755.8034910923159;782.182619162975;784.7567254151213;804.9235322644347;835.8370117827025;14540.636484087903;15582.53252402427;16622.168891555404;16875.831241687563;16897.493075207734;14327.713445731106;14335.211563364011;14459.783103253434;14534.127952322842;14543.200123993176;669.9866002679944;782.718221440281;786.567387936634;801.8636831738589;804.6982381606897;801.791534201109;807.9878801817978;810.3638643664724;811.995940020299;812.0782911395579;838.1409055717877;842.8314337132567;843.0557775291651;844.3793811548506;847.076686411811;828.5608627427473;830.3813658824155;833.4832403909585;834.9874751878666;839.0518713853337;610.1793088296234;612.1429998002787;613.0191693290744;613.6318209074519;614.2812908896557;15151.242437878062;15188.392464301414;15246.695066098617;15268.847311526853;15276.38894444221;14483.348249328805;14554;15214;15578.298976546082;15783;12710.237385756884;12761.808572871414;12808.679783005406;12833.42249598761;12918.935405322913;3933.3903244997073;4012.538558065831;4034.253663072341;4168.43726096976;4168.499780026416;87622;88145;88161;88939.11060889372;89588;11068.501917413736;11195.944020279847;11204.551817927355;11362.715932101764;11732.472038758277;22792.544149116926;23060.538789224123;23124.884375578014;23327.41681457977;23619.173328933404;8389.706360277361;8477.788055298544;8699.913000870038;8731.432456890281;8824.735257942271;4609.285560738091;4649.279361698942;4687.906241875144;4772.141014617333;4904.852854414374;3541.2032292734443;3596.5324507813816;3612.909677258037;3620.094976255936;3643.927121457556;583.2213994317549;599.1312596734665;611.3550204534171;615.3415845045758;625.1841347042154;589.4812564942823;626.9247690277105;687.9036934829128;711.9252478489788;719.7013239505651;9278.350515463988;9856.162226210852;9972.950135249423;10005.899941000642;10043.748906277255;622.3558616831558;625.1841347042154;697.4908316928569;720.1753991679498;721.6608194148741;4613.5386461354265;4655.185342565105;4717.315989181549;4787.114383838932;4797.232442809134;124691;127311;128743;128917;131210;108876;114144.42927785474;114858.42570787092;115289.4235528817;115788;57500.71249643725;57935;61845.69077154585;95528.0447195533;99084;8769.210771030383;8943.776405589912;9073.500957447404;9073.637054517745;9081.68214112503;52937.735311323195;53953.99999999843;54192;54771.452285478226;55556.16665749936;77492.61253693695;84531.57734211536;84634;85976.570117149;87650;12194.085443591943;12217.87782122203;12234.934558480732;12320.829521195472;12715;14253.714925701635;14263.135729679938;14333.283335833376;14561.199134047729;14579.343929522985;13071.215727056408;13352.065355425415;13574.117682350616;13732.313384330544;13829.170249785046;12386.504539818307;12566;12645.241285522898;12870.65867664946;12973.662190700023;12101.668816430361;12258.141930065167;12309.076819238413;12651.873481265438;12836.935815320863;9624.4119770016;9660.516974151124;9823.165030972448;9856.359336643096;10016.298859079794;9270.72187834366;10428.739281518023;10454.425006624404;10467.633632822815;10478.842817357898 14:36:55 INFO - PROCESS | 6872 | __end_tp_report 14:36:55 INFO - PROCESS | 6872 | __start_cc_report 14:36:55 INFO - PROCESS | 6872 | _x_x_mozilla_cycle_collect,354 14:36:55 INFO - PROCESS | 6872 | __end_cc_report 14:36:55 INFO - PROCESS | 6872 | __startTimestamp1466199415888__endTimestamp 14:36:55 INFO - PROCESS | 6872 | 14:36:55 INFO - PROCESS | 6872 | ------- Summary: start ------- 14:36:55 INFO - PROCESS | 6872 | Number of tests: 6 14:36:55 INFO - PROCESS | 6872 | 14:36:55 INFO - PROCESS | 6872 | [#0] dojo.html Cycles:165 Average:5353.43 Median:5551.89 stddev:584.96 (10.5%) stddev-sans-first:559.62 14:36:55 INFO - PROCESS | 6872 | Values: 3108.8 3145.2 3171.1 3180.6 3189.5 5370.4 5403.4 5429.1 5457.3 5482.8 5313.4 5332.1 5360.8 5373.7 5396.7 4860.7 4861.1 4942.2 4997.4 5034.1 4861.9 5090.2 5114.2 5115.3 5123.2 4820.5 4863.2 4882.2 4909.1 4909.4 4904.5 4915.7 4917.2 4923.8 4983.9 4893.6 4895.8 4903.7 4906.5 4932.7 5230.8 5299.4 5300.7 5364.2 5391.6 5707.6 5744.7 5747.9 5753.2 5754.6 5551.9 5785.3 5793.4 5794.3 5796.7 5408.5 5452.8 5456.3 5463.6 5468.6 5891.0 5943.5 5959.2 5961.6 5977.6 5510.3 5564.8 5730.3 5732.8 5745.5 5611.5 5713.0 5717.2 5720.9 5765.2 5608.4 5683.1 5691.8 5700.7 5705.2 5536.9 5760.8 5761.7 5762.9 5770.2 4401.9 4447.8 4451.1 4490.9 4491.4 3944.2 3963.6 3992.0 4003.5 4007.0 5406.6 5438.3 5477.7 5580.1 5623.4 5734.8 5756.6 5761.3 5766.5 5836.6 5493.4 5518.5 5519.8 5523.5 5526.2 4896.7 4917.1 4937.3 4962.9 4963.9 5853.1 5862.1 5862.4 5886.1 5951.4 5779.5 5783.9 5788.5 5796.4 5799.4 5828.2 5859.6 5866.0 5887.4 5911.7 5551.6 5581.9 5588.6 5602.9 5607.4 5650.5 5679.0 5697.5 5704.2 5705.9 5550.2 5623.9 5630.7 5695.0 5707.9 5543.9 5629.5 5643.3 5687.8 5705.4 5488.1 5514.3 5550.5 5553.9 5556.1 5585.2 5610.9 5638.8 5734.5 5735.1 5523.5 5594.0 5595.3 5603.8 5624.9 14:36:55 INFO - PROCESS | 6872 | 14:36:55 INFO - PROCESS | 6872 | [#1] ext.html Cycles:180 Average:54013.29 Median:371850.50 stddev:108439.55 (29.2%) stddev-sans-first:108669.53 14:36:55 INFO - PROCESS | 6872 | Values: 575.6 616.6 617.1 636.2 648.2 37389.0 41263.4 41305.6 41340.8 41382.0 41885.6 41921.8 42288.2 42413.8 42537.8 8745.3 8906.2 8934.3 8950.1 8963.0 8777.2 8793.7 8798.3 8916.3 8921.7 8792.1 8898.0 8930.2 8935.2 8944.0 8854.9 8895.3 8895.8 8925.2 8936.2 8712.6 8804.8 8824.4 8835.6 8859.6 40254.0 40708.0 40772.0 40782.6 40833.0 3015.3 3406.6 3435.3 3455.7 3542.3 30398.1 30475.2 31168.5 31293.8 31342.2 3574.9 3637.5 3639.6 3657.1 3833.9 303628.0 305218.0 305520.0 306031.0 306405.0 33838.3 34188.0 34310.0 34423.7 34429.5 34565.8 36211.1 36291.6 36355.1 36359.3 15628.2 15797.1 15815.7 15864.4 15874.8 12951.7 13049.8 13053.0 13068.6 13081.9 8139.0 8187.4 8190.8 8242.1 8309.0 3196.4 3196.6 3218.2 3226.8 3229.1 957.2 963.5 969.5 1002.5 1018.6 32184.8 32457.0 32458.2 32576.7 32671.5 1038.0 1061.0 1070.9 1166.1 1221.6 16181.0 16248.8 16344.8 16359.9 16501.3 515455.0 515976.0 519504.0 521704.0 523563.0 54554.2 55118.4 55241.7 55264.4 55472.2 1302.4 1334.0 1364.8 1382.3 1383.6 26985.3 27767.4 28319.9 28322.9 28415.0 40219.8 40376.8 40693.8 41721.4 41857.2 368652.0 368779.0 370896.0 371343.0 372358.0 27157.0 27282.6 27575.7 27823.2 27860.2 45949.3 46117.8 46286.0 46471.0 47388.3 40167.4 40192.4 40250.4 40517.0 40852.8 39524.4 40602.2 40604.0 40638.4 40943.6 35121.5 39066.8 39148.4 39347.2 40294.6 31699.5 36031.5 36061.3 36276.8 36504.6 27186.0 27502.4 27706.4 27779.6 27790.0 14:36:55 INFO - PROCESS | 6872 | 14:36:55 INFO - PROCESS | 6872 | [#2] jquery.html Cycles:180 Average:27332.04 Median:2885.19 stddev:72647.37 (2517.9%) stddev-sans-first:72822.96 14:36:55 INFO - PROCESS | 6872 | Values: 372.4 380.1 385.2 388.4 402.8 17569.0 19727.4 20121.1 20355.7 20393.2 18473.2 18850.2 19022.5 19207.1 19272.2 5618.2 5669.7 5759.8 5780.8 5795.7 5635.9 5640.4 5663.3 5668.1 5679.1 5277.9 5554.6 5558.5 5701.1 5718.3 5613.5 5619.9 5666.1 5694.3 5716.7 5415.8 5543.4 5547.3 5550.1 5565.7 12410.6 12600.3 19458.6 22582.0 22954.1 2350.6 2660.3 2751.1 2873.7 2896.7 9219.7 9514.2 9538.3 11267.4 14126.3 1826.0 1848.8 1877.3 1942.8 1952.1 77179.2 78444.0 79032.6 79083.6 80559.0 10612.9 10646.1 10721.9 10788.0 11074.7 15032.1 15261.8 15287.2 15312.0 15315.6 7789.1 8353.8 8422.2 8438.4 8489.7 8079.8 8131.0 8134.0 8257.0 8340.1 4314.6 4371.9 4705.8 4710.6 4852.3 1769.7 1878.4 1910.2 1949.3 1982.7 933.5 961.7 963.4 1002.6 1003.9 18505.6 19232.1 19302.2 19480.6 19961.2 953.6 955.8 986.2 1018.5 1032.0 10285.1 10882.4 10979.3 11055.2 11151.7 353946.0 361877.0 478004.0 481054.0 493039.0 80304.0 96722.0 99561.0 100496.5 101546.5 973.6 1004.8 1035.5 1039.2 1046.3 17886.7 18121.1 18131.7 18365.4 18610.1 29432.0 32422.5 40082.0 41457.4 43092.1 57708.7 58781.4 59235.7 59958.4 60152.7 8088.0 8238.4 8249.6 8552.8 8590.5 12241.8 13548.9 13643.7 13902.9 13903.7 11963.3 11987.4 12232.4 12272.3 12394.5 12050.7 12055.3 12136.6 12193.4 12316.3 11334.3 11926.3 12129.1 12165.9 12233.6 7732.0 7975.9 8186.3 8441.0 8938.8 11806.8 12084.1 12233.0 12319.6 12507.0 14:36:55 INFO - PROCESS | 6872 | 14:36:55 INFO - PROCESS | 6872 | [#3] mootools.html Cycles:180 Average:5502.76 Median:5087.82 stddev:3067.62 (60.3%) stddev-sans-first:3060.95 14:36:55 INFO - PROCESS | 6872 | Values: 1429.1 1435.8 1544.9 1658.3 1666.3 7307.0 7845.6 7848.3 8367.1 8368.7 7859.2 8037.8 8105.2 8127.3 8166.9 2245.2 2254.5 2263.4 2277.3 2291.4 2171.8 2200.0 2215.4 2235.9 2250.7 2215.3 2226.5 2226.9 2228.3 2254.1 2169.4 2178.4 2180.1 2192.0 2193.0 2192.1 2201.6 2201.8 2205.2 2210.4 8241.5 8247.9 8293.1 8337.1 8350.4 4890.3 4963.4 4971.8 4973.2 5002.9 3119.0 3170.8 3258.8 3336.8 3341.4 969.4 974.8 983.1 1019.5 1021.9 11348.7 11417.1 11430.4 11495.3 11495.8 4428.4 4449.5 4450.4 4454.9 4457.9 9654.0 9679.7 9680.0 9709.0 9743.1 4986.5 5025.9 5032.1 5040.3 5041.5 4190.4 4555.1 4668.6 4672.1 4724.7 3798.3 3804.8 3823.8 3874.6 3882.6 1224.2 1226.4 1232.3 1246.1 1248.8 886.1 933.9 957.8 966.9 985.5 5577.0 5733.1 5778.5 5806.6 5889.4 911.0 932.7 939.7 956.6 989.6 3963.1 4095.2 4148.9 4155.3 4184.6 10051.0 10195.3 10271.6 10338.7 10380.0 10178.9 10302.8 10305.9 10310.9 10325.7 7386.4 7503.4 7583.4 7586.6 7589.7 5557.9 5694.9 5850.6 5862.1 5874.3 9352.9 9480.5 9515.1 9566.9 9597.3 9226.9 9590.6 9600.8 9610.6 9649.3 6480.4 6903.3 6963.0 7145.4 7166.6 8292.9 8306.4 8330.1 8376.0 8413.5 7272.7 7453.1 7536.5 7541.8 7558.2 7239.7 7323.6 7355.7 7456.2 7502.3 6769.6 6772.4 6803.4 6805.8 6830.6 4832.0 4945.4 5076.0 5124.1 5214.8 5014.1 5099.7 5145.3 5173.9 5231.5 14:36:55 INFO - PROCESS | 6872 | 14:36:55 INFO - PROCESS | 6872 | [#4] prototype.html Cycles:180 Average:4881.45 Median:5523.54 stddev:1477.27 (26.7%) stddev-sans-first:1440.65 14:36:55 INFO - PROCESS | 6872 | Values: 289.6 302.2 304.5 305.3 309.6 5488.2 5519.2 5669.5 5724.8 5726.3 5600.0 5617.0 5620.8 5629.7 5646.1 4276.0 4306.9 4332.5 4354.4 4365.0 4074.6 4287.1 4291.2 4354.8 4385.7 4208.5 4218.6 4260.4 4261.6 4280.8 4269.2 4277.0 4292.7 4303.5 4305.7 3519.3 3729.9 3742.5 3746.5 3750.4 5471.3 5474.2 5481.4 5493.7 5507.9 4857.5 4870.5 4879.8 4885.3 4916.4 5545.4 5846.9 5885.7 5892.5 5895.4 4061.2 4062.2 4063.6 4067.6 4075.2 6136.8 6164.8 6176.2 6188.5 6195.1 4052.4 4116.5 4133.5 4164.5 4170.2 4151.7 4156.6 4179.0 4195.0 4195.6 4848.1 4859.5 4870.7 4894.0 4921.6 5662.7 5902.3 5935.6 5992.5 6006.4 1427.3 1446.0 1446.3 1449.8 1456.8 867.8 902.0 905.2 929.5 931.1 5054.4 5082.5 5098.4 5112.5 5129.8 5456.6 5474.7 5479.8 5497.6 5527.9 5039.7 5194.2 5218.2 5308.7 5774.8 3186.7 3200.7 3208.6 3215.4 3226.0 6111.9 6244.8 6265.0 6344.4 6356.0 6058.7 6118.1 6159.8 6175.0 6194.8 6087.6 6202.7 6312.6 6313.5 6317.4 5839.6 5942.8 5992.5 6053.4 6148.8 5937.6 5960.2 5960.9 5964.9 6043.4 6048.8 6221.3 6234.0 6341.7 6368.6 4154.7 4154.8 4195.7 4196.3 4204.2 6076.4 6100.1 6107.1 6131.3 6190.4 5770.5 5943.0 5944.6 5959.5 5963.9 5827.8 5896.9 5921.8 5944.9 5955.6 5443.3 5726.5 5794.5 5808.9 5819.9 5864.8 5880.5 5888.4 5905.7 5917.6 5749.8 5771.3 5774.2 5795.9 5860.5 14:36:55 INFO - PROCESS | 6872 | 14:36:55 INFO - PROCESS | 6872 | [#5] yui.html Cycles:180 Average:21886.53 Median:4671.55 stddev:33020.32 (706.8%) stddev-sans-first:33074.84 14:36:55 INFO - PROCESS | 6872 | Values: 755.8 782.2 784.8 804.9 835.8 14540.6 15582.5 16622.2 16875.8 16897.5 14327.7 14335.2 14459.8 14534.1 14543.2 670.0 782.7 786.6 801.9 804.7 801.8 808.0 810.4 812.0 812.1 838.1 842.8 843.1 844.4 847.1 828.6 830.4 833.5 835.0 839.1 610.2 612.1 613.0 613.6 614.3 15151.2 15188.4 15246.7 15268.8 15276.4 14483.3 14554.0 15214.0 15578.3 15783.0 12710.2 12761.8 12808.7 12833.4 12918.9 3933.4 4012.5 4034.3 4168.4 4168.5 87622.0 88145.0 88161.0 88939.1 89588.0 11068.5 11195.9 11204.6 11362.7 11732.5 22792.5 23060.5 23124.9 23327.4 23619.2 8389.7 8477.8 8699.9 8731.4 8824.7 4609.3 4649.3 4687.9 4772.1 4904.9 3541.2 3596.5 3612.9 3620.1 3643.9 583.2 599.1 611.4 615.3 625.2 589.5 626.9 687.9 711.9 719.7 9278.4 9856.2 9973.0 10005.9 10043.7 622.4 625.2 697.5 720.2 721.7 4613.5 4655.2 4717.3 4787.1 4797.2 124691.0 127311.0 128743.0 128917.0 131210.0 108876.0 114144.4 114858.4 115289.4 115788.0 57500.7 57935.0 61845.7 95528.0 99084.0 8769.2 8943.8 9073.5 9073.6 9081.7 52937.7 53954.0 54192.0 54771.5 55556.2 77492.6 84531.6 84634.0 85976.6 87650.0 12194.1 12217.9 12234.9 12320.8 12715.0 14253.7 14263.1 14333.3 14561.2 14579.3 13071.2 13352.1 13574.1 13732.3 13829.2 12386.5 12566.0 12645.2 12870.7 12973.7 12101.7 12258.1 12309.1 12651.9 12836.9 9624.4 9660.5 9823.2 9856.4 10016.3 9270.7 10428.7 10454.4 10467.6 10478.8 14:36:55 INFO - PROCESS | 6872 | -------- Summary: end -------- 14:36:55 INFO - PROCESS | 6872 | 14:36:56 INFO - TEST-INFO | 6872: exit 0 14:36:56 INFO - TEST-OK | dromaeo_css | took 1111177ms 14:36:56 INFO - TEST-START | kraken 14:36:56 INFO - operating with platform_type : linux_ 14:36:56 INFO - Initialising browser for kraken test... 14:36:56 INFO - TEST-INFO | started process 7107 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplHgb6K/profile http://localhost:58773/getInfo.html) 14:37:01 INFO - PROCESS | 7107 | __metrics Screen width/height:1600/1200 14:37:01 INFO - PROCESS | 7107 | colorDepth:24 14:37:01 INFO - PROCESS | 7107 | Browser inner width/height: 1024/697 14:37:01 INFO - PROCESS | 7107 | __metrics 14:37:01 ERROR - PROCESS | 7107 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 14:37:02 INFO - TEST-INFO | 7107: exit 0 14:37:02 INFO - Browser initialized. 14:37:02 INFO - Running cycle 1/1 for kraken test... 14:37:02 INFO - TEST-INFO | started process 7228 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplHgb6K/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:37:14 INFO - PROCESS | 7228 | RSS: Main: 184688640 14:37:14 INFO - PROCESS | 7228 | 14:37:17 INFO - PROCESS | 7228 | Cycle 1(1): loaded http://localhost:58773/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58773/tests/kraken/driver.html?testName=audio-beat-detection) 14:37:17 INFO - PROCESS | 7228 | RSS: Main: 190697472 14:37:17 INFO - PROCESS | 7228 | 14:37:20 INFO - PROCESS | 7228 | Cycle 1(1): loaded http://localhost:58773/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58773/tests/kraken/driver.html?testName=audio-dft) 14:37:21 INFO - PROCESS | 7228 | RSS: Main: 189788160 14:37:21 INFO - PROCESS | 7228 | 14:37:24 INFO - PROCESS | 7228 | Cycle 1(1): loaded http://localhost:58773/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58773/tests/kraken/driver.html?testName=audio-fft) 14:37:24 INFO - PROCESS | 7228 | RSS: Main: 184844288 14:37:24 INFO - PROCESS | 7228 | 14:37:26 INFO - PROCESS | 7228 | Cycle 1(1): loaded http://localhost:58773/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58773/tests/kraken/driver.html?testName=audio-oscillator) 14:37:27 INFO - PROCESS | 7228 | RSS: Main: 185823232 14:37:27 INFO - PROCESS | 7228 | 14:37:29 INFO - PROCESS | 7228 | Cycle 1(1): loaded http://localhost:58773/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58773/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:37:30 INFO - PROCESS | 7228 | RSS: Main: 186204160 14:37:30 INFO - PROCESS | 7228 | 14:37:33 INFO - PROCESS | 7228 | Cycle 1(1): loaded http://localhost:58773/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58773/tests/kraken/driver.html?testName=imaging-darkroom) 14:37:34 INFO - PROCESS | 7228 | RSS: Main: 186798080 14:37:34 INFO - PROCESS | 7228 | 14:37:37 INFO - PROCESS | 7228 | Cycle 1(1): loaded http://localhost:58773/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58773/tests/kraken/driver.html?testName=imaging-desaturate) 14:37:38 INFO - PROCESS | 7228 | RSS: Main: 186871808 14:37:38 INFO - PROCESS | 7228 | 14:37:40 INFO - PROCESS | 7228 | Cycle 1(1): loaded http://localhost:58773/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58773/tests/kraken/driver.html?testName=json-parse-financial) 14:37:41 INFO - PROCESS | 7228 | RSS: Main: 186843136 14:37:41 INFO - PROCESS | 7228 | 14:37:43 INFO - PROCESS | 7228 | Cycle 1(1): loaded http://localhost:58773/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58773/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:37:43 INFO - PROCESS | 7228 | RSS: Main: 186978304 14:37:43 INFO - PROCESS | 7228 | 14:37:45 INFO - PROCESS | 7228 | Cycle 1(1): loaded http://localhost:58773/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58773/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:37:46 INFO - PROCESS | 7228 | RSS: Main: 186986496 14:37:46 INFO - PROCESS | 7228 | 14:37:48 INFO - PROCESS | 7228 | Cycle 1(1): loaded http://localhost:58773/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58773/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:37:48 INFO - PROCESS | 7228 | RSS: Main: 187006976 14:37:48 INFO - PROCESS | 7228 | 14:37:51 INFO - PROCESS | 7228 | Cycle 1(1): loaded http://localhost:58773/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58773/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:37:52 INFO - PROCESS | 7228 | RSS: Main: 186941440 14:37:52 INFO - PROCESS | 7228 | 14:37:54 INFO - PROCESS | 7228 | Cycle 1(1): loaded http://localhost:58773/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58773/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:37:55 INFO - PROCESS | 7228 | RSS: Main: 186712064 14:37:55 INFO - PROCESS | 7228 | 14:37:57 INFO - PROCESS | 7228 | Cycle 1(1): loaded http://localhost:58773/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58773/tests/kraken/driver.html?testName=ai-astar) 14:37:57 INFO - PROCESS | 7228 | RSS: Main: 187617280 14:37:57 INFO - PROCESS | 7228 | 14:37:57 INFO - PROCESS | 7228 | __start_tp_report 14:37:57 INFO - PROCESS | 7228 | _x_x_mozilla_page_load 14:37:57 INFO - PROCESS | 7228 | _x_x_mozilla_page_load_details 14:37:57 INFO - PROCESS | 7228 | |i|pagename|runs| 14:37:57 INFO - PROCESS | 7228 | |0;ai-astar;111;107;111;109;112;110;111;112;112;110 14:37:57 INFO - PROCESS | 7228 | |1;audio-beat-detection;151;131;155;189;128;159;158;127;180;127 14:37:57 INFO - PROCESS | 7228 | |2;audio-dft;163;161;161;162;166;166;168;165;164;162 14:37:57 INFO - PROCESS | 7228 | |3;audio-fft;74;74;75;168;77;75;75;75;165;76 14:37:57 INFO - PROCESS | 7228 | |4;audio-oscillator;85;87;148;88;86;85;144;86;86;156 14:37:57 INFO - PROCESS | 7228 | |5;imaging-gaussian-blur;118;118;118;118;117;117;117;117;118;118 14:37:57 INFO - PROCESS | 7228 | |6;imaging-darkroom;146;147;147;146;148;147;147;148;148;146 14:37:57 INFO - PROCESS | 7228 | |7;imaging-desaturate;96;98;96;96;96;96;96;97;95;96 14:37:57 INFO - PROCESS | 7228 | |8;json-parse-financial;55;55;56;54;55;60;56;59;55;55 14:37:57 INFO - PROCESS | 7228 | |9;json-stringify-tinderbox;61;62;64;62;62;62;61;62;61;62 14:37:57 INFO - PROCESS | 7228 | |10;stanford-crypto-aes;80;78;79;84;82;87;85;80;103;84 14:37:57 INFO - PROCESS | 7228 | |11;stanford-crypto-ccm;138;124;131;128;127;124;122;132;142;143 14:37:57 INFO - PROCESS | 7228 | |12;stanford-crypto-pbkdf2;161;169;168;160;171;161;160;163;163;157 14:37:57 INFO - PROCESS | 7228 | |13;stanford-crypto-sha256-iterative;75;68;64;65;64;63;64;65;64;64 14:37:57 INFO - PROCESS | 7228 | __end_tp_report 14:37:57 INFO - PROCESS | 7228 | __start_cc_report 14:37:57 INFO - PROCESS | 7228 | _x_x_mozilla_cycle_collect,864 14:37:57 INFO - PROCESS | 7228 | __end_cc_report 14:37:57 INFO - PROCESS | 7228 | __startTimestamp1466199477514__endTimestamp 14:37:57 INFO - PROCESS | 7228 | 14:37:57 INFO - PROCESS | 7228 | ------- Summary: start ------- 14:37:57 INFO - PROCESS | 7228 | Number of tests: 14 14:37:57 INFO - PROCESS | 7228 | 14:37:57 INFO - PROCESS | 7228 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.00 stddev:1.58 (1.4%) stddev-sans-first:1.67 14:37:57 INFO - PROCESS | 7228 | Values: 111.0 107.0 111.0 109.0 112.0 110.0 111.0 112.0 112.0 110.0 14:37:57 INFO - PROCESS | 7228 | 14:37:57 INFO - PROCESS | 7228 | [#1] audio-beat-detection Cycles:10 Average:150.50 Median:156.50 stddev:22.34 (14.3%) stddev-sans-first:23.70 14:37:57 INFO - PROCESS | 7228 | Values: 151.0 131.0 155.0 189.0 128.0 159.0 158.0 127.0 180.0 127.0 14:37:57 INFO - PROCESS | 7228 | 14:37:57 INFO - PROCESS | 7228 | [#2] audio-dft Cycles:10 Average:163.80 Median:164.50 stddev:2.39 (1.5%) stddev-sans-first:2.52 14:37:57 INFO - PROCESS | 7228 | Values: 163.0 161.0 161.0 162.0 166.0 166.0 168.0 165.0 164.0 162.0 14:37:57 INFO - PROCESS | 7228 | 14:37:57 INFO - PROCESS | 7228 | [#3] audio-fft Cycles:10 Average:93.40 Median:75.00 stddev:38.54 (51.4%) stddev-sans-first:40.24 14:37:57 INFO - PROCESS | 7228 | Values: 74.0 74.0 75.0 168.0 77.0 75.0 75.0 75.0 165.0 76.0 14:37:57 INFO - PROCESS | 7228 | 14:37:57 INFO - PROCESS | 7228 | [#4] audio-oscillator Cycles:10 Average:105.10 Median:86.00 stddev:30.67 (35.7%) stddev-sans-first:31.66 14:37:57 INFO - PROCESS | 7228 | Values: 85.0 87.0 148.0 88.0 86.0 85.0 144.0 86.0 86.0 156.0 14:37:57 INFO - PROCESS | 7228 | 14:37:57 INFO - PROCESS | 7228 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 14:37:57 INFO - PROCESS | 7228 | Values: 118.0 118.0 118.0 118.0 117.0 117.0 117.0 117.0 118.0 118.0 14:37:57 INFO - PROCESS | 7228 | 14:37:57 INFO - PROCESS | 7228 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.78 14:37:57 INFO - PROCESS | 7228 | Values: 146.0 147.0 147.0 146.0 148.0 147.0 147.0 148.0 148.0 146.0 14:37:57 INFO - PROCESS | 7228 | 14:37:57 INFO - PROCESS | 7228 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 14:37:57 INFO - PROCESS | 7228 | Values: 96.0 98.0 96.0 96.0 96.0 96.0 96.0 97.0 95.0 96.0 14:37:57 INFO - PROCESS | 7228 | 14:37:57 INFO - PROCESS | 7228 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:55.50 stddev:1.94 (3.5%) stddev-sans-first:2.03 14:37:57 INFO - PROCESS | 7228 | Values: 55.0 55.0 56.0 54.0 55.0 60.0 56.0 59.0 55.0 55.0 14:37:57 INFO - PROCESS | 7228 | 14:37:57 INFO - PROCESS | 7228 | [#9] json-stringify-tinderbox Cycles:10 Average:61.90 Median:62.00 stddev:0.88 (1.4%) stddev-sans-first:0.87 14:37:57 INFO - PROCESS | 7228 | Values: 61.0 62.0 64.0 62.0 62.0 62.0 61.0 62.0 61.0 62.0 14:37:57 INFO - PROCESS | 7228 | 14:37:57 INFO - PROCESS | 7228 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:83.00 stddev:7.21 (8.7%) stddev-sans-first:7.48 14:37:57 INFO - PROCESS | 7228 | Values: 80.0 78.0 79.0 84.0 82.0 87.0 85.0 80.0 103.0 84.0 14:37:57 INFO - PROCESS | 7228 | 14:37:57 INFO - PROCESS | 7228 | [#11] stanford-crypto-ccm Cycles:10 Average:131.10 Median:131.50 stddev:7.59 (5.8%) stddev-sans-first:7.63 14:37:57 INFO - PROCESS | 7228 | Values: 138.0 124.0 131.0 128.0 127.0 124.0 122.0 132.0 142.0 143.0 14:37:57 INFO - PROCESS | 7228 | 14:37:57 INFO - PROCESS | 7228 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.30 Median:163.00 stddev:4.55 (2.8%) stddev-sans-first:4.75 14:37:57 INFO - PROCESS | 7228 | Values: 161.0 169.0 168.0 160.0 171.0 161.0 160.0 163.0 163.0 157.0 14:37:57 INFO - PROCESS | 7228 | 14:37:57 INFO - PROCESS | 7228 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:64.50 stddev:3.57 (5.5%) stddev-sans-first:1.42 14:37:57 INFO - PROCESS | 7228 | Values: 75.0 68.0 64.0 65.0 64.0 63.0 64.0 65.0 64.0 64.0 14:37:57 INFO - PROCESS | 7228 | -------- Summary: end -------- 14:37:57 INFO - PROCESS | 7228 | 14:37:58 INFO - TEST-INFO | 7228: exit 0 14:37:58 INFO - TEST-OK | kraken | took 61835ms 14:37:58 INFO - SUITE-END | took 1173s 14:37:58 INFO - Completed test suite (00:19:33) 14:37:58 INFO - javascript benchmark 14:37:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7104.715053763416, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3108.782385233034, 3145.2294187923962, 3171.0645359618916, 3180.570622965899, 3189.489681650935, 5370.43610420906, 5403.378611459683, 5429.131338985763, 5457.317835270591, 5482.780688772445, 5313.442088580701, 5332.14685650296, 5360.812371566996, 5373.704446255454, 5396.676199428037, 4860.684055536379, 4861.076395484864, 4942.209246520558, 4997.425296090942, 5034.11902916988, 4861.927071093936, 5090.160123579605, 5114.207297868837, 5115.258287548303, 5123.205903085028, 4820.493848145947, 4863.17326054568, 4882.218844984804, 4909.116359055369, 4909.386326709161, 4904.485029071968, 4915.680480768774, 4917.164082106051, 4923.805385318487, 4983.8504844854715, 4893.608511319086, 4895.828645997373, 4903.730294833783, 4906.484819093979, 4932.654714170009, 5230.843074707726, 5299.364076310867, 5300.734963251861, 5364.195370694388, 5391.595630327741, 5707.600467967244, 5744.6840423776675, 5747.885042299131, 5753.223314852525, 5754.568407369422, 5551.8889622207325, 5785.27684039495, 5793.391693872167, 5794.275715535558, 5796.739146738365, 5408.4591540845995, 5452.781888724447, 5456.263404440389, 5463.590230732711, 5468.589855760794, 5890.970545147246, 5943.524518038546, 5959.165716799652, 5961.552883533665, 5977.581569290195, 5510.256115424367, 5564.805231816867, 5730.283714535683, 5732.799352022659, 5745.540356771448, 5611.523020543218, 5712.971435142881, 5717.199592057115, 5720.856978575569, 5765.1928729977835, 5608.355039170466, 5683.119116536944, 5691.772329106872, 5700.743466544015, 5705.22979397776, 5536.86157846049, 5760.769569217268, 5761.654300741969, 5762.942370576325, 5770.19217309577, 4401.933970990438, 4447.844325448594, 4451.087527056946, 4490.865274041784, 4491.416115904912, 3944.1914407546383, 3963.564007959122, 3991.960080399217, 4003.5195776506425, 4007.0, 5406.648567843156, 5438.320209973754, 5477.698726570077, 5580.135079062752, 5623.437656234426, 5734.799282025109, 5756.625819321815, 5761.251037365199, 5766.538676905838, 5836.562257830679, 5493.423190565013, 5518.503334699896, 5519.834404967857, 5523.475269849358, 5526.171074338801, 4896.706197628082, 4917.1149193145575, 4937.259411088294, 4962.925556116661, 4963.880545143055, 5853.09277062056, 5862.091375836752, 5862.413758624189, 5886.087656413177, 5951.375105613848, 5779.450952159454, 5783.8554036149435, 5788.450097240755, 5796.391378905154, 5799.420057994167, 5828.154917537018, 5859.648421094748, 5866.0, 5887.4406931341455, 5911.733971971185, 5551.555875529867, 5581.860453488695, 5588.636738611977, 5602.859928501657, 5607.43925607436, 5650.547956163579, 5678.971605141948, 5697.487226149667, 5704.172894930295, 5705.914411283917, 5550.222968784454, 5623.8875222496135, 5630.690312032878, 5694.971525142348, 5707.942920570741, 5543.916841247304, 5629.521490673174, 5643.322801263875, 5687.7724891005555, 5705.429457054262, 5488.094464413327, 5514.255575497256, 5550.500454959073, 5553.916691249554, 5556.138798486241, 5585.1901474286815, 5610.887782244251, 5638.830835074954, 5734.512566431733, 5735.082386818089, 5523.502884740232, 5594.02104631696, 5595.300587426572, 5603.80386686464, 5624.943750562606], "value": 5315.364976602747, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.6488541989386, 616.5529990756701, 617.0959544267647, 636.2015670333732, 648.186525909983, 37389.0, 41263.38104928428, 41305.58694413055, 41340.79329603352, 41382.0, 41885.581144188625, 41921.79039104808, 42288.154236915245, 42413.78793106038, 42537.7873110634, 8745.300375969939, 8906.198442140207, 8934.285257179443, 8950.14973577509, 8962.955185224066, 8777.166169213915, 8793.692220772275, 8798.252148567379, 8916.286697064219, 8921.732348029569, 8792.120787921189, 8897.95551022244, 8930.151635594608, 8935.240504557121, 8944.0, 8854.911450885505, 8895.332850036208, 8895.822083558358, 8925.196732294093, 8936.240419564345, 8712.56437178145, 8804.779880502974, 8824.382293239476, 8835.602397892111, 8859.55702214893, 40254.0, 40708.0, 40772.0, 40782.59217407818, 40833.0, 3015.276333679901, 3406.6423025582453, 3435.278591495789, 3455.6544345565494, 3542.3092496963104, 30398.088057358316, 30475.23811904698, 31168.53247201294, 31293.84353078243, 31342.21644458884, 3574.8927532174075, 3637.527121474218, 3639.5996440391536, 3657.085728567858, 3833.884983450501, 303628.0, 305218.0, 305520.0, 306031.0, 306405.0, 33838.32323353519, 34188.0, 34310.0, 34423.65576344255, 34429.48355774665, 34565.82717086399, 36211.094722632144, 36291.63708362936, 36355.091122722144, 36359.27281454356, 15628.2185890705, 15797.052176869425, 15815.68368632644, 15864.365425383086, 15874.841251587568, 12951.740965180832, 13049.804252936214, 13053.0, 13068.607941761762, 13081.934590326988, 8138.959305203436, 8187.38594605407, 8190.7542773715695, 8242.093369729326, 8309.04445988719, 3196.360727854392, 3196.6164060312913, 3218.211538173116, 3226.8063916165106, 3229.128135403475, 957.157014586436, 963.5037955452947, 969.4571040217501, 1002.4737013068197, 1018.6078359831519, 32184.83907580447, 32457.0, 32458.188545286557, 32576.67423325784, 32671.509927351108, 1038.0087016898844, 1061.0, 1070.8875568065396, 1166.0613206368785, 1221.6457227403953, 16181.0, 16248.75626865598, 16344.83655163457, 16359.918200408922, 16501.33994640201, 515455.0, 515976.0, 519504.0, 521704.0, 523563.0, 54554.18168727472, 55118.44881551133, 55241.723791380784, 55264.44735552593, 55472.16791748127, 1302.446460254388, 1334.0461569977513, 1364.7884577890443, 1382.2881216173678, 1383.584924522639, 26985.325366865985, 27767.444651107267, 28319.858400707864, 28322.85838570794, 28415.0, 40219.798901005306, 40376.79811600923, 40693.79653101716, 41721.37417938794, 41857.16285674331, 368652.0, 368779.0, 370896.0, 371343.0, 372358.0, 27157.0, 27282.590761138203, 27575.724242757315, 27823.165305040882, 27860.16419507418, 45949.310760337954, 46117.76941115273, 46286.0, 46471.0, 47388.289175663085, 40167.3974890371, 40192.39711404273, 40250.396244056945, 40517.0, 40852.77441676754, 39524.40713389359, 40602.1879562413, 40604.0, 40638.39042414425, 40943.590564093975, 35121.473177902866, 39066.80466597649, 39148.412773807846, 39347.213055739296, 40294.59705402909, 31699.52450713195, 36031.45952810658, 36061.32240142808, 36276.81861590675, 36504.63495365012, 27186.0, 27502.44995100127, 27706.44587108287, 27779.583306250828, 27790.0], "value": 17945.956741826772, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.3725522494595, 380.1086452269428, 385.2410750820882, 388.3921662598034, 402.830811059355, 17569.0, 19727.40817775467, 20121.094550745216, 20355.694664580005, 20393.184272629096, 18473.168707408164, 18850.245990160412, 19022.478201743863, 19207.135678894447, 19272.22911083555, 5618.2415373924505, 5669.659820410789, 5759.769609215627, 5780.826575202751, 5795.71021448928, 5635.943640563603, 5640.379558248589, 5663.2637757091725, 5668.149777533362, 5679.091345384739, 5277.86805329866, 5554.583406244527, 5558.499735023867, 5701.087825947829, 5718.313802343704, 5613.522850557708, 5619.943800562003, 5666.093425051992, 5694.345150307726, 5716.742746576414, 5415.783368665248, 5543.417941116206, 5547.278853748987, 5550.111982082847, 5565.666060036411, 12410.627681169579, 12600.306983115925, 19458.610827783366, 22582.0, 22954.08183672651, 2350.612148995414, 2660.3349162709324, 2751.1333929812045, 2873.7126287371307, 2896.6668833084045, 9219.723408297761, 9514.191293740041, 9538.284628652878, 11267.436628168642, 14126.293685315693, 1825.954351141219, 1848.7596612440432, 1877.2678655324435, 1942.77658069321, 1952.1313015708015, 77179.22820771777, 78444.0, 79032.60483697544, 79083.60458197672, 80559.0, 10612.946935265274, 10646.095081918123, 10721.946390268155, 10788.0, 11074.667759967213, 15032.098074115587, 15261.847381526264, 15287.159206243541, 15312.0, 15315.61710957235, 7789.1042530108625, 8353.791155221168, 8422.24199822019, 8438.367122465717, 8489.660413583511, 8079.798005049921, 8130.959345203236, 8134.0, 8256.958715206505, 8340.082590914995, 4314.568543145723, 4371.912561748747, 4705.811767529329, 4710.62315014798, 4852.344933433941, 1769.6726105670234, 1878.3707458001722, 1910.2168111074393, 1949.3274820187012, 1982.732331135307, 933.453929451265, 961.6874515782399, 963.4171326347599, 1002.6139936124499, 1003.9096481316717, 18505.629887402447, 19232.134553944827, 19302.16629420231, 19480.610387792163, 19961.20155193776, 953.5756588318131, 955.8088382323563, 986.2159583131428, 1018.5009345420691, 1031.9535620897077, 10285.125764309967, 10882.401467919182, 10979.341239525655, 11055.170862185369, 11151.665450036511, 353946.0, 361877.0, 478004.0, 481054.0, 493039.0, 80304.0, 96722.0, 99561.0, 100496.49751751195, 101546.49226753818, 973.5910917414703, 1004.8090862735911, 1035.53918506264, 1039.2413538117216, 1046.3094357723867, 17886.731699024265, 18121.093945302946, 18131.728024079912, 18365.449036528924, 18610.069496524848, 29432.0, 32422.513662295558, 40082.0, 41457.37813932854, 43092.08236803198, 57708.71145644413, 58781.41218587759, 59235.703821480616, 59958.40041599703, 60152.69923650354, 8088.029436467662, 8238.382121341043, 8249.628766705393, 8552.786180345542, 8590.527520986405, 12241.755164896475, 13548.932255338661, 13643.727125457634, 13902.860971390157, 13903.721925561635, 11963.342016188844, 11987.400629968291, 12232.388380581113, 12272.263664180178, 12394.504219831466, 12050.698732531406, 12055.336956467478, 12136.635900922987, 12193.390330483262, 12316.261024338568, 11334.263272887236, 11926.344051077274, 12129.090318226345, 12165.878341216474, 12233.571824986082, 7731.961340193263, 7975.880361794461, 8186.2632363087605, 8441.029281632691, 8938.821223575622, 11806.82289765637, 12084.093692972887, 12233.0, 12319.63041108768, 12507.0], "value": 9158.914995328389, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1429.128231778615, 1435.7559214933462, 1544.9227538623065, 1658.2537857963919, 1666.2834980958182, 7307.0, 7845.568493732842, 7848.2544158304945, 8367.121452247518, 8368.707095251668, 7859.214078592138, 8037.799055023627, 8105.230003149706, 8127.268545830874, 8166.877496837537, 2245.191730976851, 2254.5265494246228, 2263.4341414646337, 2277.339571524256, 2291.4271432141963, 2171.7502487213937, 2199.967000494994, 2215.401841502793, 2235.9217427390045, 2250.6849041134174, 2215.324326080545, 2226.476777957179, 2226.92205772798, 2228.2980861028805, 2254.0870947266385, 2169.3600387885613, 2178.4336072621154, 2180.0952604669124, 2192.0, 2193.024104273599, 2192.1012384922105, 2201.6037113319594, 2201.7798220178015, 2205.1730601024615, 2210.3700445372992, 8241.464304820227, 8247.917520824834, 8293.087760346358, 8337.124601916832, 8350.373721970876, 4890.315355850148, 4963.354763880672, 4971.801127954877, 4973.204287314013, 5002.9499705002845, 3118.984405077983, 3170.8414579270943, 3258.771885967983, 3336.7831090979007, 3341.398548261312, 969.3795970578835, 974.7514383832078, 983.1201075037801, 1019.5208252121491, 1021.8671572695501, 11348.716282092932, 11417.086633069335, 11430.37132957687, 11495.310281383145, 11495.827562586568, 4428.446444194476, 4449.488308844459, 4450.421445212101, 4454.866354009385, 4457.888552786207, 9653.951730241444, 9679.70960871175, 9680.031996800264, 9709.0, 9743.123118919331, 4986.4514903360605, 5025.874353141127, 5032.0690672225755, 5040.344755181803, 5041.521055499722, 4190.350495673176, 4555.134524440412, 4668.603168730696, 4672.135654903854, 4724.740139292372, 3798.2973149967343, 3804.752691075071, 3823.808809559511, 3874.643874643852, 3882.6311500407414, 1224.1736827641307, 1226.3806777577267, 1232.2729589542214, 1246.1401632873287, 1248.7877060899668, 886.1271647427279, 933.9112784285481, 957.7892863570004, 966.9274804389698, 985.4678473624163, 5577.024020796344, 5733.111367738007, 5778.508826749773, 5806.564507661942, 5889.411058894077, 911.0479548871446, 932.7061975477839, 939.6617217801586, 956.5552018311519, 989.618996686281, 3963.1083006323925, 4095.2219078375015, 4148.896277593084, 4155.335146376626, 4184.602462766033, 10051.0, 10195.286329956833, 10271.589136434608, 10338.741531461774, 10380.0, 10178.949105254575, 10302.845457318146, 10305.948470257601, 10310.948445257725, 10325.74185645365, 7386.446016548673, 7503.437242206747, 7583.393328533593, 7586.582737949356, 7589.734359297398, 5557.916631250615, 5694.886102278014, 5850.64896106235, 5862.120681897579, 5874.265716785402, 9352.859707104535, 9480.478573678514, 9515.143637072697, 9566.856497152687, 9597.32818702712, 9226.907730922605, 9590.568424421057, 9600.75998100053, 9610.567524461276, 9649.276304277348, 6480.384363485461, 6903.275156108536, 6962.965185174245, 7145.3926416253125, 7166.605836678824, 8292.917070829215, 8306.377021723274, 8330.083690793886, 8376.0, 8413.45312554682, 7272.672729727281, 7453.068366454193, 7536.472446928662, 7541.811454713676, 7558.2441755823975, 7239.746608868664, 7323.63381830917, 7355.7057717690695, 7456.217097204715, 7502.324790768857, 6769.593824370553, 6772.356626120511, 6803.421709154777, 6805.829854253485, 6830.624315662488, 4831.95168048315, 4945.357103576512, 5075.974620126875, 5124.052050370693, 5214.843554693365, 5014.07239660664, 5099.6685215460875, 5145.279660847559, 5173.92239116406, 5231.529162375405], "value": 4430.4005079762255, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [289.5931216640619, 302.1871166561948, 304.4869395069307, 305.26735833998407, 309.6037072547139, 5488.204210389491, 5519.227308176848, 5669.518090962268, 5724.7996320128805, 5726.255586773714, 5599.972000139994, 5617.022977821761, 5620.775168993236, 5629.746661400237, 5646.096624540074, 4276.0, 4306.892327691801, 4332.458442694663, 4354.390385346054, 4365.039691267916, 4074.5925407459167, 4287.142571485715, 4291.249031419505, 4354.80403381847, 4385.736855788647, 4208.473940757405, 4218.578142185772, 4260.36094585813, 4261.616454519092, 4280.807363668642, 4269.1675123351115, 4277.0, 4292.7424354538825, 4303.483581970152, 4305.741655500648, 3519.3137338219058, 3729.850805967785, 3742.4947632069593, 3746.4942232798494, 3750.3999360102252, 5471.288732464794, 5474.178873169017, 5481.424450432727, 5493.670379777186, 5507.862303442406, 4857.514248575149, 4870.464248932614, 4879.756012199411, 4885.2916327132725, 4916.410030796327, 5545.417731138213, 5846.924341858621, 5885.676287804169, 5892.469677729025, 5895.41045895407, 4061.208064427438, 4062.2484840304637, 4063.573324800883, 4067.5763482781085, 4075.205334959684, 6136.785212517585, 6164.7534098636, 6176.227971503562, 6188.504919606421, 6195.101710252034, 4052.4124002019544, 4116.464859568297, 4133.483314585676, 4164.541900390955, 4170.249355116108, 4151.6886233532605, 4156.584341565819, 4179.0, 4194.958050419517, 4195.643370313496, 4848.127337079289, 4859.465458799529, 4870.707757534488, 4894.0, 4921.606271498343, 5662.669272720907, 5902.291724993029, 5935.60513279379, 5992.490638295706, 6006.399360064046, 1427.2578259305103, 1446.0383844743337, 1446.2551785830306, 1449.8039117727706, 1456.7523521001456, 867.7830542364409, 901.963921443148, 905.1672461335587, 929.4516235420999, 931.0689310689311, 5054.368203974504, 5082.491750824888, 5098.388193416814, 5112.463191364927, 5129.820456284012, 5456.590755693339, 5474.742528195718, 5479.75341109651, 5497.587680923947, 5527.861803454945, 5039.7228152451235, 5194.168932970707, 5218.217267409843, 5308.654937429054, 5774.82675519735, 3186.713195812388, 3200.7439404848024, 3208.6149662040702, 3215.3569286142865, 3225.9838700806813, 6111.877762444727, 6244.750209991549, 6265.0, 6344.382182543422, 6355.968220158869, 6058.697380063308, 6118.1434599156155, 6159.753609855646, 6175.011998080286, 6194.81415557534, 6087.573869829158, 6202.666426718277, 6312.589681670676, 6313.494920406449, 6317.399847014526, 5839.620424672553, 5942.821715348547, 5992.520598352208, 6053.424924632153, 6148.754049837957, 5937.643741375531, 5960.195373624505, 5960.8807823844145, 5964.850878728066, 6043.425874541911, 6048.758049677964, 6221.346758590464, 6233.96883015582, 6341.651209183355, 6368.649724265025, 4154.688398370195, 4154.771487568213, 4195.685323600803, 4196.349565817303, 4204.222218889515, 6076.422739839708, 6100.145979562776, 6107.144999699956, 6131.325554189125, 6190.442860142609, 5770.5095066919785, 5942.970285148546, 5944.554158438221, 5959.4934430573885, 5963.896679114378, 5827.76688932438, 5896.850114227685, 5921.792737254175, 5944.910826337695, 5955.612885162451, 5443.346798384061, 5726.513246374105, 5794.536437084938, 5808.883822323445, 5819.912701309569, 5864.794732184353, 5880.529557635294, 5888.440598143341, 5905.675187864708, 5917.556183286185, 5749.798757043483, 5771.307443106854, 5774.220480235114, 5795.884082318415, 5860.531157507475], "value": 4391.044930603297, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [755.8034910923159, 782.182619162975, 784.7567254151213, 804.9235322644347, 835.8370117827025, 14540.636484087903, 15582.53252402427, 16622.168891555404, 16875.831241687563, 16897.493075207734, 14327.713445731106, 14335.211563364011, 14459.783103253434, 14534.127952322842, 14543.200123993176, 669.9866002679944, 782.718221440281, 786.567387936634, 801.8636831738589, 804.6982381606897, 801.791534201109, 807.9878801817978, 810.3638643664724, 811.995940020299, 812.0782911395579, 838.1409055717877, 842.8314337132567, 843.0557775291651, 844.3793811548506, 847.076686411811, 828.5608627427473, 830.3813658824155, 833.4832403909585, 834.9874751878666, 839.0518713853337, 610.1793088296234, 612.1429998002787, 613.0191693290744, 613.6318209074519, 614.2812908896557, 15151.242437878062, 15188.392464301414, 15246.695066098617, 15268.847311526853, 15276.38894444221, 14483.348249328805, 14554.0, 15214.0, 15578.298976546082, 15783.0, 12710.237385756884, 12761.808572871414, 12808.679783005406, 12833.42249598761, 12918.935405322913, 3933.3903244997073, 4012.538558065831, 4034.253663072341, 4168.43726096976, 4168.499780026416, 87622.0, 88145.0, 88161.0, 88939.11060889372, 89588.0, 11068.501917413736, 11195.944020279847, 11204.551817927355, 11362.715932101764, 11732.472038758277, 22792.544149116926, 23060.538789224123, 23124.884375578014, 23327.41681457977, 23619.173328933404, 8389.706360277361, 8477.788055298544, 8699.913000870038, 8731.432456890281, 8824.735257942271, 4609.285560738091, 4649.279361698942, 4687.906241875144, 4772.141014617333, 4904.852854414374, 3541.2032292734443, 3596.5324507813816, 3612.909677258037, 3620.094976255936, 3643.927121457556, 583.2213994317549, 599.1312596734665, 611.3550204534171, 615.3415845045758, 625.1841347042154, 589.4812564942823, 626.9247690277105, 687.9036934829128, 711.9252478489788, 719.7013239505651, 9278.350515463988, 9856.162226210852, 9972.950135249423, 10005.899941000642, 10043.748906277255, 622.3558616831558, 625.1841347042154, 697.4908316928569, 720.1753991679498, 721.6608194148741, 4613.5386461354265, 4655.185342565105, 4717.315989181549, 4787.114383838932, 4797.232442809134, 124691.0, 127311.0, 128743.0, 128917.0, 131210.0, 108876.0, 114144.42927785474, 114858.42570787092, 115289.4235528817, 115788.0, 57500.71249643725, 57935.0, 61845.69077154585, 95528.0447195533, 99084.0, 8769.210771030383, 8943.776405589912, 9073.500957447404, 9073.637054517745, 9081.68214112503, 52937.735311323195, 53953.99999999843, 54192.0, 54771.452285478226, 55556.16665749936, 77492.61253693695, 84531.57734211536, 84634.0, 85976.570117149, 87650.0, 12194.085443591943, 12217.87782122203, 12234.934558480732, 12320.829521195472, 12715.0, 14253.714925701635, 14263.135729679938, 14333.283335833376, 14561.199134047729, 14579.343929522985, 13071.215727056408, 13352.065355425415, 13574.117682350616, 13732.313384330544, 13829.170249785046, 12386.504539818307, 12566.0, 12645.241285522898, 12870.65867664946, 12973.662190700023, 12101.668816430361, 12258.141930065167, 12309.076819238413, 12651.873481265438, 12836.935815320863, 9624.4119770016, 9660.516974151124, 9823.165030972448, 9856.359336643096, 10016.298859079794, 9270.72187834366, 10428.739281518023, 10454.425006624404, 10467.633632822815, 10478.842817357898], "value": 7566.316560886552, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1546.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 107.0, 111.0, 109.0, 112.0, 110.0, 111.0, 112.0, 112.0, 110.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 131.0, 155.0, 189.0, 128.0, 159.0, 158.0, 127.0, 180.0, 127.0], "value": 150.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 161.0, 162.0, 166.0, 166.0, 168.0, 165.0, 164.0, 162.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 168.0, 77.0, 75.0, 75.0, 75.0, 165.0, 76.0], "value": 93.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 148.0, 88.0, 86.0, 85.0, 144.0, 86.0, 86.0, 156.0], "value": 105.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 146.0, 148.0, 147.0, 147.0, 148.0, 148.0, 146.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 98.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 95.0, 96.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 56.0, 54.0, 55.0, 60.0, 56.0, 59.0, 55.0, 55.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 64.0, 62.0, 62.0, 62.0, 61.0, 62.0, 61.0, 62.0], "value": 61.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 79.0, 84.0, 82.0, 87.0, 85.0, 80.0, 103.0, 84.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 124.0, 131.0, 128.0, 127.0, 124.0, 122.0, 132.0, 142.0, 143.0], "value": 131.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 169.0, 168.0, 160.0, 171.0, 161.0, 160.0, 163.0, 163.0, 157.0], "value": 163.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 68.0, 64.0, 65.0, 64.0, 63.0, 64.0, 65.0, 64.0, 64.0], "value": 65.6, "unit": "score"}]}]} 14:37:58 INFO - Return code: 0 14:37:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:37:58 ERROR - # TBPL SUCCESS # 14:37:58 INFO - Running post-action listener: _resource_record_post_action 14:37:58 INFO - ##### 14:37:58 INFO - ##### Finished run-tests step (success) 14:37:58 INFO - ##### 14:37:58 INFO - Running post-run listener: _resource_record_post_run 14:37:58 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 551456768; Read time: 12; Write time: 553288 14:37:58 INFO - TinderboxPrint: CPU usage
13.5% 14:37:58 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 14:37:58 INFO - TinderboxPrint: I/O write bytes / time
551,456,768 / 553,288 14:37:58 INFO - TinderboxPrint: CPU idle
8,218.0 (86.5%) 14:37:58 INFO - TinderboxPrint: CPU user
1,225.4 (12.9%) 14:37:58 INFO - TinderboxPrint: Swap in / out
0 / 0 14:37:58 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 257830912; Read time: 0; Write time: 326452 14:37:58 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293625856; Read time: 12; Write time: 226836 14:37:59 INFO - Running post-run listener: _upload_blobber_files 14:37:59 INFO - Blob upload gear active. 14:37:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:37:59 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 14:37:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:37:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:37:59 INFO - (blobuploader) - INFO - Open directory for files ... 14:37:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:37:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:37:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:38:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:38:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:38:00 INFO - (blobuploader) - INFO - Done attempting. 14:38:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:38:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:38:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:38:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:38:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:38:04 INFO - (blobuploader) - INFO - Done attempting. 14:38:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:38:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:38:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:38:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:38:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:38:05 INFO - (blobuploader) - INFO - Done attempting. 14:38:05 INFO - (blobuploader) - INFO - Iteration through files over. 14:38:05 INFO - Return code: 0 14:38:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:38:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:38:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6d6be341b86a3241eebae23a10b4f7127ed0639b789f0b99bdf75b24555fecd66336085abb42c6c36181ead5dda0c6aa0e60509a54409a9c352e54f7eaa429f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2d0e4891f37e2c1bdab4a3112ccc4b20b4a1f8a3651f4c2379f9b6d063351309041a810e51536facd6f268868284fa4c25c25de5fd6d8de610772ed85db53cf3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bb3679eb85bc95fabbd0382f1fcb12df99b9dd3775b8b42954c2c222206348c08abaddb3e197442defa778b8dd0dbf4a2693173ab2f5d2c89d425bbaa43d8c0b"} 14:38:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:38:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:38:05 INFO - Contents: 14:38:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6d6be341b86a3241eebae23a10b4f7127ed0639b789f0b99bdf75b24555fecd66336085abb42c6c36181ead5dda0c6aa0e60509a54409a9c352e54f7eaa429f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2d0e4891f37e2c1bdab4a3112ccc4b20b4a1f8a3651f4c2379f9b6d063351309041a810e51536facd6f268868284fa4c25c25de5fd6d8de610772ed85db53cf3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bb3679eb85bc95fabbd0382f1fcb12df99b9dd3775b8b42954c2c222206348c08abaddb3e197442defa778b8dd0dbf4a2693173ab2f5d2c89d425bbaa43d8c0b"} 14:38:05 INFO - Running post-run listener: copy_logs_to_upload_dir 14:38:05 INFO - Copying logs to upload dir... 14:38:05 INFO - mkdir: /builds/slave/test/build/upload/logs 14:38:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.522320 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-06-17 14:38:05.116225) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-17 14:38:05.120073) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1466196116.115765-315994287 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/sha512/6d6be341b86a3241eebae23a10b4f7127ed0639b789f0b99bdf75b24555fecd66336085abb42c6c36181ead5dda0c6aa0e60509a54409a9c352e54f7eaa429f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2d0e4891f37e2c1bdab4a3112ccc4b20b4a1f8a3651f4c2379f9b6d063351309041a810e51536facd6f268868284fa4c25c25de5fd6d8de610772ed85db53cf3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bb3679eb85bc95fabbd0382f1fcb12df99b9dd3775b8b42954c2c222206348c08abaddb3e197442defa778b8dd0dbf4a2693173ab2f5d2c89d425bbaa43d8c0b"} build_url:https://queue.taskcluster.net/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011296 build_url: 'https://queue.taskcluster.net/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6d6be341b86a3241eebae23a10b4f7127ed0639b789f0b99bdf75b24555fecd66336085abb42c6c36181ead5dda0c6aa0e60509a54409a9c352e54f7eaa429f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2d0e4891f37e2c1bdab4a3112ccc4b20b4a1f8a3651f4c2379f9b6d063351309041a810e51536facd6f268868284fa4c25c25de5fd6d8de610772ed85db53cf3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bb3679eb85bc95fabbd0382f1fcb12df99b9dd3775b8b42954c2c222206348c08abaddb3e197442defa778b8dd0dbf4a2693173ab2f5d2c89d425bbaa43d8c0b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-17 14:38:05.145725) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 14:38:05.146062) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1466196116.115765-315994287 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004419 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 14:38:05.228667) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-17 14:38:05.228982) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-17 14:38:05.229362) ========= ========= Total master_lag: 0.18 =========