builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-025 starttime: 1466674353.3 results: success (0) buildid: 20160622234707 builduid: c6ff59ffb4aa40afbb526fc4b08ddfeb revision: 437fc937572dd344f58226d40ba9eccb4ffcaedb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 02:32:33.304606) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 02:32:33.305620) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 02:32:33.306144) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 02:32:33.327624) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 02:32:33.328280) ========= 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=232498196343f89f466a4a9a000001c8-1466674352.122626-1345932662 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-23 02:32:33-- 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% 29.0M=0s 2016-06-23 02:32:33 (29.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.134287 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 02:32:33.504404) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 02:32:33.505116) ========= 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=232498196343f89f466a4a9a000001c8-1466674352.122626-1345932662 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.110839 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 02:32:33.629720) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 02:32:33.630130) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 437fc937572dd344f58226d40ba9eccb4ffcaedb --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 437fc937572dd344f58226d40ba9eccb4ffcaedb --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=232498196343f89f466a4a9a000001c8-1466674352.122626-1345932662 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-23 02:32:33,680 truncating revision to first 12 chars 2016-06-23 02:32:33,680 Setting DEBUG logging. 2016-06-23 02:32:33,681 attempt 1/10 2016-06-23 02:32:33,681 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/437fc937572d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-23 02:32:34,296 unpacking tar archive at: fx-team-437fc937572d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.952119 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 02:32:34.596851) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 02:32:34.597277) ========= script_repo_revision: 437fc937572dd344f58226d40ba9eccb4ffcaedb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 02:32:34.597824) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 02:32:34.598202) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 02:32:34.609021) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-06-23 02:32:34.609351) ========= /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=232498196343f89f466a4a9a000001c8-1466674352.122626-1345932662 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:32:34 INFO - MultiFileLogger online at 20160623 02:32:34 in /builds/slave/test 02:32:34 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 02:32:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:32:34 INFO - {'append_to_log': False, 02:32:34 INFO - 'base_work_dir': '/builds/slave/test', 02:32:34 INFO - 'blob_upload_branch': 'Fx-Team', 02:32:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:32:34 INFO - 'branch': 'Fx-Team', 02:32:34 INFO - 'buildbot_json_path': 'buildprops.json', 02:32:34 INFO - 'config_files': ('talos/linux_config.py',), 02:32:34 INFO - 'default_actions': ('clobber', 02:32:34 INFO - 'read-buildbot-config', 02:32:34 INFO - 'download-and-extract', 02:32:34 INFO - 'populate-webroot', 02:32:34 INFO - 'create-virtualenv', 02:32:34 INFO - 'install', 02:32:34 INFO - 'run-tests'), 02:32:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:32:34 INFO - 'download_minidump_stackwalk': True, 02:32:34 INFO - 'download_symbols': 'ondemand', 02:32:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:32:34 INFO - 'tooltool.py': '/tools/tooltool.py', 02:32:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:32:34 INFO - '/tools/misc-python/virtualenv.py')}, 02:32:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:32:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:32:34 INFO - 'installer_path': 'installer.exe', 02:32:34 INFO - 'log_level': 'info', 02:32:34 INFO - 'log_name': 'talos', 02:32:34 INFO - 'log_to_console': True, 02:32:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:32:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:32:34 INFO - 'opt_config_files': (), 02:32:34 INFO - 'pip_index': False, 02:32:34 INFO - 'sps_profile': False, 02:32:34 INFO - 'sps_profile_interval': 0, 02:32:34 INFO - 'suite': 'dromaeojs-e10s', 02:32:34 INFO - 'system_bits': '32', 02:32:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:32:34 INFO - 'title': 'talos-linux64-ix-025', 02:32:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:32:34 INFO - 'use_talos_json': True, 02:32:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:32:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:32:34 INFO - 'work_dir': 'build'} 02:32:34 INFO - ##### 02:32:34 INFO - ##### Running clobber step. 02:32:34 INFO - ##### 02:32:34 INFO - Running pre-action listener: _resource_record_pre_action 02:32:34 INFO - Running main action method: clobber 02:32:34 INFO - rmtree: /builds/slave/test/build 02:32:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:32:37 INFO - Running post-action listener: _resource_record_post_action 02:32:37 INFO - ##### 02:32:37 INFO - ##### Finished clobber step (success) 02:32:37 INFO - ##### 02:32:37 INFO - ##### 02:32:37 INFO - ##### Running read-buildbot-config step. 02:32:37 INFO - ##### 02:32:37 INFO - Running pre-action listener: _resource_record_pre_action 02:32:37 INFO - Running main action method: read_buildbot_config 02:32:37 INFO - Using buildbot properties: 02:32:37 INFO - { 02:32:37 INFO - "project": "", 02:32:37 INFO - "product": "firefox", 02:32:37 INFO - "script_repo_revision": "production", 02:32:37 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 02:32:37 INFO - "repository": "", 02:32:37 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 02:32:37 INFO - "buildid": "20160622234707", 02:32:37 INFO - "pgo_build": "True", 02:32:37 INFO - "basedir": "/builds/slave/test", 02:32:37 INFO - "buildnumber": 496, 02:32:37 INFO - "slavename": "talos-linux64-ix-025", 02:32:37 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:32:37 INFO - "platform": "ubuntu64_hw", 02:32:37 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:32:37 INFO - "branch": "fx-team", 02:32:37 INFO - "repo_path": "integration/fx-team", 02:32:37 INFO - "revision": "437fc937572dd344f58226d40ba9eccb4ffcaedb", 02:32:37 INFO - "stage_platform": "linux64-pgo", 02:32:37 INFO - "builduid": "c6ff59ffb4aa40afbb526fc4b08ddfeb", 02:32:37 INFO - "slavebuilddir": "test" 02:32:37 INFO - } 02:32:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/M0c7I6k6SPGMfnUxsOzNCg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 02:32:37 INFO - Running post-action listener: _resource_record_post_action 02:32:37 INFO - ##### 02:32:37 INFO - ##### Finished read-buildbot-config step (success) 02:32:37 INFO - ##### 02:32:37 INFO - ##### 02:32:37 INFO - ##### Running download-and-extract step. 02:32:37 INFO - ##### 02:32:37 INFO - Running pre-action listener: _resource_record_pre_action 02:32:37 INFO - Running main action method: download_and_extract 02:32:37 INFO - mkdir: /builds/slave/test/build/tests 02:32:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:32:37 INFO - https://queue.taskcluster.net/v1/task/M0c7I6k6SPGMfnUxsOzNCg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:32:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M0c7I6k6SPGMfnUxsOzNCg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:32:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M0c7I6k6SPGMfnUxsOzNCg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:32:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M0c7I6k6SPGMfnUxsOzNCg/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 02:32:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M0c7I6k6SPGMfnUxsOzNCg/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 02:32:37 INFO - Downloaded 1361 bytes. 02:32:37 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:32:37 INFO - Using the following test package requirements: 02:32:37 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:32:37 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:32:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:32:37 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:32:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:32:37 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:32:37 INFO - u'jsshell-linux-x86_64.zip'], 02:32:37 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:32:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:32:37 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:32:37 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:32:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:32:37 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:32:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:32:37 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:32:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:32:37 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:32:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:32:37 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:32:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:32:37 INFO - https://queue.taskcluster.net/v1/task/M0c7I6k6SPGMfnUxsOzNCg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:32:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M0c7I6k6SPGMfnUxsOzNCg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:32:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M0c7I6k6SPGMfnUxsOzNCg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:32:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M0c7I6k6SPGMfnUxsOzNCg/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 02:32:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M0c7I6k6SPGMfnUxsOzNCg/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 02:32:39 INFO - Downloaded 24269439 bytes. 02:32:39 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'] 02:32:39 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 02:32:40 INFO - Return code: 0 02:32:40 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 02:32:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:32:40 INFO - https://queue.taskcluster.net/v1/task/M0c7I6k6SPGMfnUxsOzNCg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:32:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M0c7I6k6SPGMfnUxsOzNCg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:32:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M0c7I6k6SPGMfnUxsOzNCg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:32:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M0c7I6k6SPGMfnUxsOzNCg/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 02:32:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M0c7I6k6SPGMfnUxsOzNCg/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 02:32:41 INFO - Downloaded 24269439 bytes. 02:32:41 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'] 02:32:41 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 02:32:43 INFO - Return code: 0 02:32:43 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')]} 02:32:43 INFO - https://queue.taskcluster.net/v1/task/M0c7I6k6SPGMfnUxsOzNCg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:32:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M0c7I6k6SPGMfnUxsOzNCg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:32:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M0c7I6k6SPGMfnUxsOzNCg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:32:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M0c7I6k6SPGMfnUxsOzNCg/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 02:32:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M0c7I6k6SPGMfnUxsOzNCg/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 02:32:44 INFO - Downloaded 14405384 bytes. 02:32:44 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'] 02:32:44 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 02:32:44 INFO - Return code: 0 02:32:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:32:44 INFO - https://queue.taskcluster.net/v1/task/M0c7I6k6SPGMfnUxsOzNCg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:32:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M0c7I6k6SPGMfnUxsOzNCg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:32:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M0c7I6k6SPGMfnUxsOzNCg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:32:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M0c7I6k6SPGMfnUxsOzNCg/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 02:32:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M0c7I6k6SPGMfnUxsOzNCg/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 02:32:45 INFO - Downloaded 60154354 bytes. 02:32:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M0c7I6k6SPGMfnUxsOzNCg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:32:45 INFO - mkdir: /builds/slave/test/properties 02:32:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:32:45 INFO - Writing to file /builds/slave/test/properties/build_url 02:32:45 INFO - Contents: 02:32:45 INFO - build_url:https://queue.taskcluster.net/v1/task/M0c7I6k6SPGMfnUxsOzNCg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:32:46 INFO - Running post-action listener: _resource_record_post_action 02:32:46 INFO - Running post-action listener: set_extra_try_arguments 02:32:46 INFO - ##### 02:32:46 INFO - ##### Finished download-and-extract step (success) 02:32:46 INFO - ##### 02:32:46 INFO - ##### 02:32:46 INFO - ##### Running populate-webroot step. 02:32:46 INFO - ##### 02:32:46 INFO - Running pre-action listener: _resource_record_pre_action 02:32:46 INFO - Running main action method: populate_webroot 02:32:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:32:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:32:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:32:46 INFO - '--tppagecycles', 02:32:46 INFO - '7'], 02:32:46 INFO - 'tests': ['tsvgm']}}, 02:32:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:32:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:32:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:32:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:32:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:32:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:32:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:46 INFO - 'talos_options': ['--disable-e10s'], 02:32:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:32:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:32:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:46 INFO - 'talos_options': ['--disable-e10s'], 02:32:46 INFO - 'tests': ['damp', 'tps']}, 02:32:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:46 INFO - 'tests': ['damp', 'tps']}, 02:32:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:32:46 INFO - 'tests': ['dromaeo_dom']}, 02:32:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:32:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:32:46 INFO - 'tests': ['basic_compositor_video']}, 02:32:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:32:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:32:46 INFO - 'tests': ['a11yr', 02:32:46 INFO - 'ts_paint', 02:32:46 INFO - 'tpaint', 02:32:46 INFO - 'sessionrestore', 02:32:46 INFO - 'sessionrestore_no_auto_restore', 02:32:46 INFO - 'tabpaint']}, 02:32:46 INFO - 'other-e10s': {'tests': ['a11yr', 02:32:46 INFO - 'ts_paint', 02:32:46 INFO - 'tpaint', 02:32:46 INFO - 'sessionrestore', 02:32:46 INFO - 'sessionrestore_no_auto_restore', 02:32:46 INFO - 'tabpaint']}, 02:32:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:32:46 INFO - 'ts_paint', 02:32:46 INFO - 'tpaint', 02:32:46 INFO - 'sessionrestore', 02:32:46 INFO - 'sessionrestore_no_auto_restore', 02:32:46 INFO - 'tabpaint']}, 02:32:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:32:46 INFO - 'ts_paint', 02:32:46 INFO - 'tpaint', 02:32:46 INFO - 'sessionrestore', 02:32:46 INFO - 'sessionrestore_no_auto_restore', 02:32:46 INFO - 'tabpaint']}, 02:32:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:32:46 INFO - 'tests': ['a11yr', 02:32:46 INFO - 'ts_paint', 02:32:46 INFO - 'tpaint', 02:32:46 INFO - 'sessionrestore', 02:32:46 INFO - 'sessionrestore_no_auto_restore', 02:32:46 INFO - 'tabpaint']}, 02:32:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:32:46 INFO - 'tests': ['a11yr', 02:32:46 INFO - 'ts_paint', 02:32:46 INFO - 'tpaint', 02:32:46 INFO - 'sessionrestore', 02:32:46 INFO - 'sessionrestore_no_auto_restore', 02:32:46 INFO - 'tabpaint']}, 02:32:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:32:46 INFO - 'tests': ['tsvgx', 02:32:46 INFO - 'tsvgr_opacity', 02:32:46 INFO - 'tart', 02:32:46 INFO - 'tscrollx', 02:32:46 INFO - 'cart']}, 02:32:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:32:46 INFO - 'tsvgr_opacity', 02:32:46 INFO - 'tart', 02:32:46 INFO - 'tscrollx', 02:32:46 INFO - 'cart']}, 02:32:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:46 INFO - 'talos_options': ['--disable-e10s'], 02:32:46 INFO - 'tests': ['tp5o']}, 02:32:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:46 INFO - 'tests': ['tp5o']}, 02:32:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:46 INFO - 'talos_options': ['--disable-e10s', 02:32:46 INFO - '--xperf_path', 02:32:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:32:46 INFO - 'tests': ['tp5n']}, 02:32:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:46 INFO - 'talos_options': ['--xperf_path', 02:32:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:32:46 INFO - 'tests': ['tp5n']}}, 02:32:46 INFO - 'talos.zip': {'path': '', 02:32:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:32:46 INFO - Running post-action listener: _resource_record_post_action 02:32:46 INFO - ##### 02:32:46 INFO - ##### Finished populate-webroot step (success) 02:32:46 INFO - ##### 02:32:46 INFO - ##### 02:32:46 INFO - ##### Running create-virtualenv step. 02:32:46 INFO - ##### 02:32:46 INFO - Running pre-action listener: _resource_record_pre_action 02:32:46 INFO - Running main action method: create_virtualenv 02:32:46 INFO - Creating virtualenv /builds/slave/test/build/venv 02:32:46 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 02:32:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:32:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:32:46 INFO - Using real prefix '/usr' 02:32:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:32:47 INFO - Installing distribute.............................................................................................................................................................................................done. 02:32:52 INFO - Installing pip.................done. 02:32:52 INFO - Return code: 0 02:32:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:32:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:32:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:32:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7e1ef4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16be1c0>, '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 0x16bf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bf550>, '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': '232498196343f89f466a4a9a000001c8-1466674352.122626-1345932662', '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 02:32:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:32:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:32:52 INFO - Using env: {'DISPLAY': ':0', 02:32:52 INFO - 'HOME': '/home/cltbld', 02:32:52 INFO - 'LANG': 'en_US.UTF-8', 02:32:52 INFO - 'LANGUAGE': 'en_US:en', 02:32:52 INFO - 'LOGNAME': 'cltbld', 02:32:52 INFO - 'MAIL': '/var/mail/cltbld', 02:32:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:52 INFO - 'MOZ_NO_REMOTE': '1', 02:32:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:52 INFO - 'NO_EM_RESTART': '1', 02:32:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:52 INFO - 'PWD': '/builds/slave/test', 02:32:52 INFO - 'SHELL': '/bin/bash', 02:32:52 INFO - 'SHLVL': '1', 02:32:52 INFO - 'TERM': 'linux', 02:32:52 INFO - 'TMOUT': '86400', 02:32:52 INFO - 'USER': 'cltbld', 02:32:52 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466674352.122626-1345932662', 02:32:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:52 INFO - '_': '/tools/buildbot/bin/python'} 02:32:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:53 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 02:32:53 INFO - Cleaning up... 02:32:53 INFO - Return code: 0 02:32:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:32: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')]} 02:32:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32: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')]} 02:32:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32: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', '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 0x7fc7e1ef4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16be1c0>, '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 0x16bf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bf550>, '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': '232498196343f89f466a4a9a000001c8-1466674352.122626-1345932662', '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 02:32: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', 'psutil>=3.1.1'] in /builds/slave/test/build 02:32: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 psutil>=3.1.1 02:32:53 INFO - Using env: {'DISPLAY': ':0', 02:32:53 INFO - 'HOME': '/home/cltbld', 02:32:53 INFO - 'LANG': 'en_US.UTF-8', 02:32:53 INFO - 'LANGUAGE': 'en_US:en', 02:32:53 INFO - 'LOGNAME': 'cltbld', 02:32:53 INFO - 'MAIL': '/var/mail/cltbld', 02:32:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:53 INFO - 'MOZ_NO_REMOTE': '1', 02:32:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:53 INFO - 'NO_EM_RESTART': '1', 02:32:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:53 INFO - 'PWD': '/builds/slave/test', 02:32:53 INFO - 'SHELL': '/bin/bash', 02:32:53 INFO - 'SHLVL': '1', 02:32:53 INFO - 'TERM': 'linux', 02:32:53 INFO - 'TMOUT': '86400', 02:32:53 INFO - 'USER': 'cltbld', 02:32:53 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466674352.122626-1345932662', 02:32:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:53 INFO - '_': '/tools/buildbot/bin/python'} 02:32:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:53 INFO - Downloading/unpacking psutil>=3.1.1 02:32: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 02:32: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 02:32: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 02:32: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 02:32: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 02:32: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 02:32:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:32:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:32:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:32:55 INFO - Installing collected packages: psutil 02:32:55 INFO - Running setup.py install for psutil 02:32:55 INFO - building 'psutil._psutil_linux' extension 02:32:55 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 02:32:56 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 02:32:56 INFO - building 'psutil._psutil_posix' extension 02:32:56 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 02:32:57 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 02:32:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:32:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:32:57 INFO - Successfully installed psutil 02:32:57 INFO - Cleaning up... 02:32:57 INFO - Return code: 0 02:32:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:32:57 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')]} 02:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:57 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')]} 02:32:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:57 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 0x7fc7e1ef4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16be1c0>, '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 0x16bf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bf550>, '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': '232498196343f89f466a4a9a000001c8-1466674352.122626-1345932662', '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 02:32:57 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 02:32:57 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 02:32:57 INFO - Using env: {'DISPLAY': ':0', 02:32:57 INFO - 'HOME': '/home/cltbld', 02:32:57 INFO - 'LANG': 'en_US.UTF-8', 02:32:57 INFO - 'LANGUAGE': 'en_US:en', 02:32:57 INFO - 'LOGNAME': 'cltbld', 02:32:57 INFO - 'MAIL': '/var/mail/cltbld', 02:32:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:57 INFO - 'MOZ_NO_REMOTE': '1', 02:32:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:57 INFO - 'NO_EM_RESTART': '1', 02:32:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:57 INFO - 'PWD': '/builds/slave/test', 02:32:57 INFO - 'SHELL': '/bin/bash', 02:32:57 INFO - 'SHLVL': '1', 02:32:57 INFO - 'TERM': 'linux', 02:32:57 INFO - 'TMOUT': '86400', 02:32:57 INFO - 'USER': 'cltbld', 02:32:57 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466674352.122626-1345932662', 02:32:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:57 INFO - '_': '/tools/buildbot/bin/python'} 02:32:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:33:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:33:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:33:02 INFO - Installing collected packages: mozsystemmonitor 02:33:02 INFO - Running setup.py install for mozsystemmonitor 02:33:02 INFO - Successfully installed mozsystemmonitor 02:33:02 INFO - Cleaning up... 02:33:02 INFO - Return code: 0 02:33:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:33:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:02 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 0x7fc7e1ef4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16be1c0>, '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 0x16bf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bf550>, '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': '232498196343f89f466a4a9a000001c8-1466674352.122626-1345932662', '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 02:33:02 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 02:33:02 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 02:33:02 INFO - Using env: {'DISPLAY': ':0', 02:33:02 INFO - 'HOME': '/home/cltbld', 02:33:02 INFO - 'LANG': 'en_US.UTF-8', 02:33:02 INFO - 'LANGUAGE': 'en_US:en', 02:33:02 INFO - 'LOGNAME': 'cltbld', 02:33:02 INFO - 'MAIL': '/var/mail/cltbld', 02:33:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:02 INFO - 'MOZ_NO_REMOTE': '1', 02:33:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:02 INFO - 'NO_EM_RESTART': '1', 02:33:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:02 INFO - 'PWD': '/builds/slave/test', 02:33:02 INFO - 'SHELL': '/bin/bash', 02:33:02 INFO - 'SHLVL': '1', 02:33:02 INFO - 'TERM': 'linux', 02:33:02 INFO - 'TMOUT': '86400', 02:33:02 INFO - 'USER': 'cltbld', 02:33:02 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466674352.122626-1345932662', 02:33:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:02 INFO - '_': '/tools/buildbot/bin/python'} 02:33:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:02 INFO - Downloading/unpacking jsonschema==2.5.1 02:33:02 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 02:33:02 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 02:33:02 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 02:33:02 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 02:33:02 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 02:33:02 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 02:33:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:33:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:33: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 02:33: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 02:33: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 02:33: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 02:33: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 02:33: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 02:33:04 INFO - Downloading functools32-3.2.3-2.tar.gz 02:33:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:33:04 INFO - warning: no files found matching '*.txt' 02:33:04 INFO - no previously-included directories found matching 'build' 02:33:04 INFO - no previously-included directories found matching 'dist' 02:33:04 INFO - no previously-included directories found matching '.git*' 02:33:04 INFO - Installing collected packages: jsonschema, functools32 02:33:05 INFO - Running setup.py install for functools32 02:33:05 INFO - warning: no files found matching '*.txt' 02:33:05 INFO - no previously-included directories found matching 'build' 02:33:05 INFO - no previously-included directories found matching 'dist' 02:33:05 INFO - no previously-included directories found matching '.git*' 02:33:05 INFO - Successfully installed jsonschema functools32 02:33:05 INFO - Cleaning up... 02:33:05 INFO - Return code: 0 02:33:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:33:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:05 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 0x7fc7e1ef4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16be1c0>, '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 0x16bf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bf550>, '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': '232498196343f89f466a4a9a000001c8-1466674352.122626-1345932662', '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 02:33:05 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 02:33:05 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 02:33:05 INFO - Using env: {'DISPLAY': ':0', 02:33:05 INFO - 'HOME': '/home/cltbld', 02:33:05 INFO - 'LANG': 'en_US.UTF-8', 02:33:05 INFO - 'LANGUAGE': 'en_US:en', 02:33:05 INFO - 'LOGNAME': 'cltbld', 02:33:05 INFO - 'MAIL': '/var/mail/cltbld', 02:33:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:05 INFO - 'MOZ_NO_REMOTE': '1', 02:33:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:05 INFO - 'NO_EM_RESTART': '1', 02:33:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:05 INFO - 'PWD': '/builds/slave/test', 02:33:05 INFO - 'SHELL': '/bin/bash', 02:33:05 INFO - 'SHLVL': '1', 02:33:05 INFO - 'TERM': 'linux', 02:33:05 INFO - 'TMOUT': '86400', 02:33:05 INFO - 'USER': 'cltbld', 02:33:05 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466674352.122626-1345932662', 02:33:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:05 INFO - '_': '/tools/buildbot/bin/python'} 02:33:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:05 INFO - Downloading/unpacking blobuploader==1.2.4 02:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:07 INFO - Downloading blobuploader-1.2.4.tar.gz 02:33:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:33:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:33:07 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 02:33:07 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 02:33:07 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 02:33:07 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 02:33:07 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 02:33:07 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 02:33:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:33:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:33:07 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 02:33:07 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 02:33:07 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 02:33:07 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 02:33:07 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 02:33:07 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 02:33:07 INFO - Downloading docopt-0.6.1.tar.gz 02:33:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:33:08 INFO - Installing collected packages: blobuploader, requests, docopt 02:33:08 INFO - Running setup.py install for blobuploader 02:33:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:33:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:33:08 INFO - Running setup.py install for requests 02:33:08 INFO - Running setup.py install for docopt 02:33:08 INFO - Successfully installed blobuploader requests docopt 02:33:08 INFO - Cleaning up... 02:33:08 INFO - Return code: 0 02:33:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:33:08 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')]} 02:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:08 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')]} 02:33:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:08 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 0x7fc7e1ef4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16be1c0>, '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 0x16bf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bf550>, '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': '232498196343f89f466a4a9a000001c8-1466674352.122626-1345932662', '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 02:33:08 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 02:33:08 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 02:33:08 INFO - Using env: {'DISPLAY': ':0', 02:33:08 INFO - 'HOME': '/home/cltbld', 02:33:08 INFO - 'LANG': 'en_US.UTF-8', 02:33:08 INFO - 'LANGUAGE': 'en_US:en', 02:33:08 INFO - 'LOGNAME': 'cltbld', 02:33:08 INFO - 'MAIL': '/var/mail/cltbld', 02:33:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:08 INFO - 'MOZ_NO_REMOTE': '1', 02:33:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:08 INFO - 'NO_EM_RESTART': '1', 02:33:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:08 INFO - 'PWD': '/builds/slave/test', 02:33:08 INFO - 'SHELL': '/bin/bash', 02:33:08 INFO - 'SHLVL': '1', 02:33:08 INFO - 'TERM': 'linux', 02:33:08 INFO - 'TMOUT': '86400', 02:33:08 INFO - 'USER': 'cltbld', 02:33:08 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466674352.122626-1345932662', 02:33:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:08 INFO - '_': '/tools/buildbot/bin/python'} 02:33:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:33:08 INFO - Running setup.py (path:/tmp/pip-6kn2zW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:33:08 INFO - Running setup.py (path:/tmp/pip-AXX5ps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:33:09 INFO - Running setup.py (path:/tmp/pip-OIB1R5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:33:09 INFO - Running setup.py (path:/tmp/pip-YimqPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:33:09 INFO - Running setup.py (path:/tmp/pip-Ue6toK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:33:09 INFO - Running setup.py (path:/tmp/pip-SEjmNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:33:09 INFO - Running setup.py (path:/tmp/pip-hSXfCu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:33:09 INFO - Running setup.py (path:/tmp/pip-SyTQuS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:33:09 INFO - Running setup.py (path:/tmp/pip-_Ucd0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:33:09 INFO - Running setup.py (path:/tmp/pip-VQ8ZMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:33:09 INFO - Running setup.py (path:/tmp/pip-b2fYx0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:33:09 INFO - Running setup.py (path:/tmp/pip-ysIJPZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:33:09 INFO - Running setup.py (path:/tmp/pip-5ySIk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:33:09 INFO - Running setup.py (path:/tmp/pip-wxsqxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:33:09 INFO - Running setup.py (path:/tmp/pip-egPCCB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:33:09 INFO - Running setup.py (path:/tmp/pip-2rKrjt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:33:10 INFO - Running setup.py (path:/tmp/pip-h0EXvs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:33:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:33:10 INFO - Running setup.py install for manifestparser 02:33:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:33:10 INFO - Running setup.py install for mozcrash 02:33:10 INFO - Running setup.py install for mozdebug 02:33:10 INFO - Running setup.py install for mozdevice 02:33:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:33:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:33:10 INFO - Running setup.py install for mozfile 02:33:10 INFO - Running setup.py install for mozhttpd 02:33:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:33:10 INFO - Running setup.py install for mozinfo 02:33:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:33:10 INFO - Running setup.py install for mozInstall 02:33:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:33:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:33:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:33:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:33:10 INFO - Running setup.py install for mozleak 02:33:10 INFO - Running setup.py install for mozlog 02:33:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:33:11 INFO - Running setup.py install for moznetwork 02:33:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:33:11 INFO - Running setup.py install for mozprocess 02:33:11 INFO - Running setup.py install for mozprofile 02:33:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:33:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:33:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:33:11 INFO - Running setup.py install for mozrunner 02:33:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:33:11 INFO - Running setup.py install for mozscreenshot 02:33:11 INFO - Running setup.py install for moztest 02:33:11 INFO - Running setup.py install for mozversion 02:33:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:33:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:33:11 INFO - Cleaning up... 02:33:11 INFO - Return code: 0 02:33:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:33:11 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')]} 02:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:11 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')]} 02:33:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:11 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 0x7fc7e1ef4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16be1c0>, '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 0x16bf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bf550>, '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': '232498196343f89f466a4a9a000001c8-1466674352.122626-1345932662', '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 02:33:11 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 02:33:11 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 02:33:11 INFO - Using env: {'DISPLAY': ':0', 02:33:11 INFO - 'HOME': '/home/cltbld', 02:33:11 INFO - 'LANG': 'en_US.UTF-8', 02:33:11 INFO - 'LANGUAGE': 'en_US:en', 02:33:11 INFO - 'LOGNAME': 'cltbld', 02:33:11 INFO - 'MAIL': '/var/mail/cltbld', 02:33:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:11 INFO - 'MOZ_NO_REMOTE': '1', 02:33:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:11 INFO - 'NO_EM_RESTART': '1', 02:33:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:11 INFO - 'PWD': '/builds/slave/test', 02:33:11 INFO - 'SHELL': '/bin/bash', 02:33:11 INFO - 'SHLVL': '1', 02:33:11 INFO - 'TERM': 'linux', 02:33:11 INFO - 'TMOUT': '86400', 02:33:11 INFO - 'USER': 'cltbld', 02:33:11 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466674352.122626-1345932662', 02:33:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:11 INFO - '_': '/tools/buildbot/bin/python'} 02:33:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:33:12 INFO - Running setup.py (path:/tmp/pip-ssqwIy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:33:12 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)) 02:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:33:12 INFO - Running setup.py (path:/tmp/pip-F4aEAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:33:12 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)) 02:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:33:12 INFO - Running setup.py (path:/tmp/pip-7temrc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:33:12 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)) 02:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:33:12 INFO - Running setup.py (path:/tmp/pip-HSaDln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:33:12 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)) 02:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:33:12 INFO - Running setup.py (path:/tmp/pip-bibbqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:33:12 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)) 02:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:33:12 INFO - Running setup.py (path:/tmp/pip-jwxX1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:33:12 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)) 02:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:33:12 INFO - Running setup.py (path:/tmp/pip-llPejl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:33:12 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)) 02:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:33:12 INFO - Running setup.py (path:/tmp/pip-wG2xuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:33:12 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)) 02:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:33:12 INFO - Running setup.py (path:/tmp/pip-WVKo6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:33:12 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)) 02:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:33:12 INFO - Running setup.py (path:/tmp/pip-u1lOhS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:33:12 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)) 02:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:33:12 INFO - Running setup.py (path:/tmp/pip-cW5MAx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:33:12 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)) 02:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:33:12 INFO - Running setup.py (path:/tmp/pip-eUR3e7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:33:12 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)) 02:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:33:12 INFO - Running setup.py (path:/tmp/pip-vjm7Ff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:33:13 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)) 02:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:33:13 INFO - Running setup.py (path:/tmp/pip-vddD0_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:33:13 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)) 02:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:33:13 INFO - Running setup.py (path:/tmp/pip-2RPJEg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:33:13 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)) 02:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:33:13 INFO - Running setup.py (path:/tmp/pip-e8wvZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:33:13 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)) 02:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:33:13 INFO - Running setup.py (path:/tmp/pip-DUot6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:33:13 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)) 02:33:13 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)) 02:33:13 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)) 02:33:13 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)) 02:33:13 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)) 02:33:13 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)) 02:33:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:33:13 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 02:33:13 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 02:33:13 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 02:33:13 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 02:33:13 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 02:33:13 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 02:33:15 INFO - Downloading blessings-1.6.tar.gz 02:33:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:33:15 INFO - Installing collected packages: blessings 02:33:15 INFO - Running setup.py install for blessings 02:33:15 INFO - Successfully installed blessings 02:33:15 INFO - Cleaning up... 02:33:15 INFO - Return code: 0 02:33:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:33:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:33:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:33:15 INFO - Reading from file tmpfile_stdout 02:33:15 INFO - Current package versions: 02:33:15 INFO - argparse == 1.2.1 02:33:15 INFO - blessings == 1.6 02:33:15 INFO - blobuploader == 1.2.4 02:33:15 INFO - docopt == 0.6.1 02:33:15 INFO - functools32 == 3.2.3-2 02:33:15 INFO - jsonschema == 2.5.1 02:33:15 INFO - manifestparser == 1.1 02:33:15 INFO - mozInstall == 1.12 02:33:15 INFO - mozcrash == 0.17 02:33:15 INFO - mozdebug == 0.1 02:33:15 INFO - mozdevice == 0.48 02:33:15 INFO - mozfile == 1.2 02:33:15 INFO - mozhttpd == 0.7 02:33:15 INFO - mozinfo == 0.9 02:33:15 INFO - mozleak == 0.1 02:33:15 INFO - mozlog == 3.2 02:33:15 INFO - moznetwork == 0.27 02:33:15 INFO - mozprocess == 0.22 02:33:15 INFO - mozprofile == 0.28 02:33:15 INFO - mozrunner == 6.11 02:33:15 INFO - mozscreenshot == 0.1 02:33:15 INFO - mozsystemmonitor == 0.3 02:33:15 INFO - moztest == 0.7 02:33:15 INFO - mozversion == 1.4 02:33:15 INFO - psutil == 3.1.1 02:33:15 INFO - requests == 1.2.3 02:33:15 INFO - wsgiref == 0.1.2 02:33:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:33:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:15 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 0x7fc7e1ef4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16be1c0>, '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 0x16bf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bf550>, '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': '232498196343f89f466a4a9a000001c8-1466674352.122626-1345932662', '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 02:33:15 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 02:33:15 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 02:33:15 INFO - Using env: {'DISPLAY': ':0', 02:33:15 INFO - 'HOME': '/home/cltbld', 02:33:15 INFO - 'LANG': 'en_US.UTF-8', 02:33:15 INFO - 'LANGUAGE': 'en_US:en', 02:33:15 INFO - 'LOGNAME': 'cltbld', 02:33:15 INFO - 'MAIL': '/var/mail/cltbld', 02:33:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:15 INFO - 'MOZ_NO_REMOTE': '1', 02:33:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:15 INFO - 'NO_EM_RESTART': '1', 02:33:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:15 INFO - 'PWD': '/builds/slave/test', 02:33:15 INFO - 'SHELL': '/bin/bash', 02:33:15 INFO - 'SHLVL': '1', 02:33:15 INFO - 'TERM': 'linux', 02:33:15 INFO - 'TMOUT': '86400', 02:33:15 INFO - 'USER': 'cltbld', 02:33:15 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466674352.122626-1345932662', 02:33:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:15 INFO - '_': '/tools/buildbot/bin/python'} 02:33:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:15 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)) 02:33:15 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)) 02:33:15 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)) 02:33:15 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)) 02:33:15 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)) 02:33:15 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)) 02:33:15 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)) 02:33:15 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)) 02:33:15 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)) 02:33:15 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)) 02:33:15 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)) 02:33:15 INFO - Cleaning up... 02:33:15 INFO - Return code: 0 02:33:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:33:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:33:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7e1ef4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16be1c0>, '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 0x16bf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bf550>, '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': '232498196343f89f466a4a9a000001c8-1466674352.122626-1345932662', '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 02:33:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:33:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:33:15 INFO - Using env: {'DISPLAY': ':0', 02:33:15 INFO - 'HOME': '/home/cltbld', 02:33:15 INFO - 'LANG': 'en_US.UTF-8', 02:33:15 INFO - 'LANGUAGE': 'en_US:en', 02:33:15 INFO - 'LOGNAME': 'cltbld', 02:33:15 INFO - 'MAIL': '/var/mail/cltbld', 02:33:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:15 INFO - 'MOZ_NO_REMOTE': '1', 02:33:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:15 INFO - 'NO_EM_RESTART': '1', 02:33:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:15 INFO - 'PWD': '/builds/slave/test', 02:33:15 INFO - 'SHELL': '/bin/bash', 02:33:15 INFO - 'SHLVL': '1', 02:33:15 INFO - 'TERM': 'linux', 02:33:15 INFO - 'TMOUT': '86400', 02:33:15 INFO - 'USER': 'cltbld', 02:33:15 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466674352.122626-1345932662', 02:33:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:15 INFO - '_': '/tools/buildbot/bin/python'} 02:33:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:33:16 INFO - Cleaning up... 02:33:16 INFO - Return code: 0 02:33:16 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:33:16 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')]} 02:33:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:33:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:16 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')]} 02:33:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:33:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:33:16 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 0x7fc7e1ef4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15648a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162f350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16be1c0>, '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 0x16bf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bf550>, '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': '232498196343f89f466a4a9a000001c8-1466674352.122626-1345932662', '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 02:33:16 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 02:33:16 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 02:33:16 INFO - Using env: {'DISPLAY': ':0', 02:33:16 INFO - 'HOME': '/home/cltbld', 02:33:16 INFO - 'LANG': 'en_US.UTF-8', 02:33:16 INFO - 'LANGUAGE': 'en_US:en', 02:33:16 INFO - 'LOGNAME': 'cltbld', 02:33:16 INFO - 'MAIL': '/var/mail/cltbld', 02:33:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:16 INFO - 'MOZ_NO_REMOTE': '1', 02:33:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:16 INFO - 'NO_EM_RESTART': '1', 02:33:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:16 INFO - 'PWD': '/builds/slave/test', 02:33:16 INFO - 'SHELL': '/bin/bash', 02:33:16 INFO - 'SHLVL': '1', 02:33:16 INFO - 'TERM': 'linux', 02:33:16 INFO - 'TMOUT': '86400', 02:33:16 INFO - 'USER': 'cltbld', 02:33:16 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466674352.122626-1345932662', 02:33:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:16 INFO - '_': '/tools/buildbot/bin/python'} 02:33:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:33:16 INFO - Downloading/unpacking flake8 02:33:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:33:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:33:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:33:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:33:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:33:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:33:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:33:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:33:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:33:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:33:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:33:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:33:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:33:18 INFO - no previously-included directories found matching 'docs/_build' 02:33:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:33:19 INFO - Running setup.py install for pep8 02:33:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:33:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:33:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:33:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:33:19 INFO - no previously-included directories found matching 'docs/_build' 02:33:19 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:33:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:33:19 INFO - Cleaning up... 02:33:19 INFO - Return code: 0 02:33:19 INFO - Running post-action listener: _resource_record_post_action 02:33:19 INFO - Running post-action listener: _start_resource_monitoring 02:33:19 INFO - Starting resource monitoring. 02:33:19 INFO - ##### 02:33:19 INFO - ##### Finished create-virtualenv step (success) 02:33:19 INFO - ##### 02:33:19 INFO - ##### 02:33:19 INFO - ##### Running install step. 02:33:19 INFO - ##### 02:33:19 INFO - Running pre-action listener: _resource_record_pre_action 02:33:19 INFO - Running main action method: install 02:33:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:33:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:33:19 INFO - Reading from file tmpfile_stdout 02:33:19 INFO - Detecting whether we're running mozinstall >=1.0... 02:33:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:33:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:33:19 INFO - Reading from file tmpfile_stdout 02:33:19 INFO - Output received: 02:33:19 INFO - Usage: mozinstall [options] installer 02:33:19 INFO - Options: 02:33:19 INFO - -h, --help show this help message and exit 02:33:19 INFO - -d DEST, --destination=DEST 02:33:19 INFO - Directory to install application into. [default: 02:33:19 INFO - "/builds/slave/test"] 02:33:19 INFO - --app=APP Application being installed. [default: firefox] 02:33:19 INFO - mkdir: /builds/slave/test/build/application 02:33:19 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'] 02:33:19 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 02:33:36 INFO - Reading from file tmpfile_stdout 02:33:36 INFO - Output received: 02:33:36 INFO - /builds/slave/test/build/application/firefox/firefox 02:33:36 INFO - Running post-action listener: _resource_record_post_action 02:33:36 INFO - ##### 02:33:36 INFO - ##### Finished install step (success) 02:33:36 INFO - ##### 02:33:36 INFO - ##### 02:33:36 INFO - ##### Running run-tests step. 02:33:36 INFO - ##### 02:33:36 INFO - Running pre-action listener: _resource_record_pre_action 02:33:36 INFO - Running main action method: run_tests 02:33:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:33:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:33:36 INFO - Python 2.7.3 02:33:36 INFO - Return code: 0 02:33:36 INFO - grabbing minidump binary from tooltool 02:33:36 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')]} 02:33:36 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 0x16be1c0>, '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 0x16bf0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bf550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:33:36 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 02:33:36 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 02:33:36 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 02:33:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:33:36 INFO - Return code: 0 02:33:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:33:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:33:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:33:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:33:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:33:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:33:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:33:37 INFO - Return code: 0 02:33:37 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/M0c7I6k6SPGMfnUxsOzNCg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 02:33:37 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/M0c7I6k6SPGMfnUxsOzNCg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --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 02:33:37 INFO - Using env: {'DISPLAY': ':0', 02:33:37 INFO - 'HOME': '/home/cltbld', 02:33:37 INFO - 'LANG': 'en_US.UTF-8', 02:33:37 INFO - 'LANGUAGE': 'en_US:en', 02:33:37 INFO - 'LOGNAME': 'cltbld', 02:33:37 INFO - 'MAIL': '/var/mail/cltbld', 02:33:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:33:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:33:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:33:37 INFO - 'MOZ_NO_REMOTE': '1', 02:33:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:33:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:33:37 INFO - 'NO_EM_RESTART': '1', 02:33:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:33:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:33:37 INFO - 'PWD': '/builds/slave/test', 02:33:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:33:37 INFO - 'SHELL': '/bin/bash', 02:33:37 INFO - 'SHLVL': '1', 02:33:37 INFO - 'TERM': 'linux', 02:33:37 INFO - 'TMOUT': '86400', 02:33:37 INFO - 'USER': 'cltbld', 02:33:37 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1466674352.122626-1345932662', 02:33:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:33:37 INFO - '_': '/tools/buildbot/bin/python'} 02:33:37 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/M0c7I6k6SPGMfnUxsOzNCg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 02:33:38 INFO - mozversion application_buildid: 20160622234707 02:33:38 INFO - mozversion application_changeset: 437fc937572dd344f58226d40ba9eccb4ffcaedb 02:33:38 INFO - mozversion application_display_name: Nightly 02:33:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:33:38 INFO - mozversion application_name: Firefox 02:33:38 INFO - mozversion application_remotingname: firefox 02:33:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:33:38 INFO - mozversion application_vendor: Mozilla 02:33:38 INFO - mozversion application_version: 50.0a1 02:33:38 INFO - mozversion platform_buildid: 20160622234707 02:33:38 INFO - mozversion platform_changeset: 437fc937572dd344f58226d40ba9eccb4ffcaedb 02:33:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:33:38 INFO - mozversion platform_version: 50.0a1 02:33:38 INFO - using testdate: 1466674418 02:33:38 INFO - actual date: 1466674418 02:33:38 INFO - starting webserver on 'localhost:54786' 02:33:38 INFO - SUITE-START | Running 2 tests 02:33:38 INFO - TEST-START | dromaeo_css 02:33:38 INFO - operating with platform_type : linux_ 02:33:38 INFO - Initialising browser for dromaeo_css test... 02:33:38 INFO - TEST-INFO | started process 3322 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpav2GCI/profile http://localhost:54786/getInfo.html) 02:33:44 INFO - PROCESS | 3322 | __metrics Screen width/height:1600/1200 02:33:44 INFO - PROCESS | 3322 | colorDepth:24 02:33:44 INFO - PROCESS | 3322 | Browser inner width/height: 1024/697 02:33:44 INFO - PROCESS | 3322 | __metrics 02:33:44 ERROR - PROCESS | 3322 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 02:33:45 INFO - TEST-INFO | 3322: exit 0 02:33:45 INFO - Browser initialized. 02:33:45 INFO - Running cycle 1/1 for dromaeo_css test... 02:33:45 INFO - TEST-INFO | started process 3444 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpav2GCI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:33:57 INFO - PROCESS | 3444 | RSS: Main: 185544704 02:33:57 INFO - PROCESS | 3444 | 02:34:47 INFO - PROCESS | 3444 | 1466674487368 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] 02:36:55 INFO - PROCESS | 3444 | Cycle 1(1): loaded http://localhost:54786/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54786/tests/dromaeo/cssquery-ext.html) 02:36:56 INFO - PROCESS | 3444 | RSS: Main: 188702720 02:36:56 INFO - PROCESS | 3444 | 02:39:58 INFO - PROCESS | 3444 | Cycle 1(1): loaded http://localhost:54786/tests/dromaeo/cssquery-ext.html (next: http://localhost:54786/tests/dromaeo/cssquery-jquery.html) 02:39:59 INFO - PROCESS | 3444 | RSS: Main: 188055552 02:39:59 INFO - PROCESS | 3444 | 02:43:01 INFO - PROCESS | 3444 | Cycle 1(1): loaded http://localhost:54786/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54786/tests/dromaeo/cssquery-mootools.html) 02:43:01 INFO - PROCESS | 3444 | RSS: Main: 189296640 02:43:01 INFO - PROCESS | 3444 | 02:46:03 INFO - PROCESS | 3444 | Cycle 1(1): loaded http://localhost:54786/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54786/tests/dromaeo/cssquery-prototype.html) 02:46:04 INFO - PROCESS | 3444 | RSS: Main: 186920960 02:46:04 INFO - PROCESS | 3444 | 02:49:06 INFO - PROCESS | 3444 | Cycle 1(1): loaded http://localhost:54786/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54786/tests/dromaeo/cssquery-yui.html) 02:49:07 INFO - PROCESS | 3444 | RSS: Main: 189108224 02:49:07 INFO - PROCESS | 3444 | 02:52:09 INFO - PROCESS | 3444 | Cycle 1(1): loaded http://localhost:54786/tests/dromaeo/cssquery-yui.html (next: http://localhost:54786/tests/dromaeo/cssquery-dojo.html) 02:52:09 INFO - PROCESS | 3444 | RSS: Main: 189816832 02:52:09 INFO - PROCESS | 3444 | 02:52:09 INFO - PROCESS | 3444 | __start_tp_report 02:52:09 INFO - PROCESS | 3444 | _x_x_mozilla_page_load 02:52:09 INFO - PROCESS | 3444 | _x_x_mozilla_page_load_details 02:52:09 INFO - PROCESS | 3444 | |i|pagename|runs| 02:52:09 INFO - PROCESS | 3444 | |0;dojo.html;3078.492048811946;3093.3658599987007;3130.593022907022;3137.215696075981;3144.355407141536;5336.439673834245;5354.571634269254;5424.457554244574;5444.945550544493;5451.073317536018;5279.868003299919;5343.1718083697;5347.759350829212;5439.836804895849;5459.727013649322;4797.6161907047435;4821.132196204681;4861.708297502143;4973.353464049686;5007.774650140753;4821.30091136785;5069.391672999245;5084.79660813567;5085.618578606601;5094.414142373619;4842.394700662418;4894.241392584155;4919.606431485473;4970.975145124287;4999.075171093341;4928.162212423897;4940.1601727706375;4941.579965702919;4943.184374578226;4998.750062496861;4926.753662316905;4927.802887884481;4944.085344211332;4949.158643030693;4969.13040217964;5228.79084836606;5397.352317721859;5411.107167317388;5458.399576046631;5490.3411590609385;5799.21710569072;5817.796377126822;5828.883422331572;5832.270966129234;5859.8535036624;5610.775568977236;5911.763529458816;5917.289925208959;5918.437748413894;5923.496502797268;5388.164834450667;5417.214503896913;5418.4039755626845;5419.810306639288;5426.213199086111;5882.705864706748;5891.381404952418;5891.911621325684;5901.203337549462;5906.409359064145;5613.887722245532;5652.208690783294;5655.773769049192;5659.490645841812;5735.827925162252;5859;5884.9705751470965;5898.4101589840675;5918.23063001807;5937.910931336033;5541.944580554224;5733.426657334233;5842.298924129047;5884.382139875337;5912.852178695567;5546.251256080377;5741.110127930177;5793.188953546507;5800.506956908625;5802.82591522255;4388.670849686287;4404.6035856772405;4425.491068527161;4427.402300689366;4457.442819647544;3934.881953541398;3956.7625942443547;3962.6829853611644;3968.980155099206;3982.8008599570485;5457.890842183214;5497.202905578669;5524.861878452991;5564.527015203753;5600.775968961278;5925.081612350093;5942.37605051472;5946.970265148647;5958.195643588147;5985.191999080155;5641.294838145232;5650.7739690412745;5667.489925906688;5668.489835914787;5673.971630141823;4902.362692849907;4992.251162325608;5003.224500202475;5035.345405097314;5086.745662716849;6022.3676513966275;6026.427489388501;6028.969855150696;6037.486813620803;6042.214512113485;5800.796972105956;5807.883842323215;5810.883782324415;5829.3296270927685;5831.970840145772;5869.970650146722;5969.761209551743;5990.4908082813445;6034.125051867367;6072.514198863992;5736.340320863154;5747.5689323300085;5749.568782341257;5759.308882934075;5770.538356931352;5705.885882282414;5864.618799778172;5874.441928016831;5879.588428809942;5882.23530940975;5537.584681149011;5734.111212762028;5756.913646295393;5780.104083867007;5781.479666830005;5556.555475562026;5576.944230557642;5663.263775709132;5674.4892959633835;5692.402297758676;5587.832365029056;5595.776168953359;5598.468145526169;5603.887922241451;5604.495595396434;5535.086710692691;5741.397153299011;5754.6547207167705;5818.563607729522;5823.854403639943;5672.262605861211;5681.460261275172;5682.431756824284;5684.8010319638615;5700.2304688868135 02:52:09 INFO - PROCESS | 3444 | |1;ext.html;585.9443352881477;606.833120891755;615.8460384903774;640.7981485831963;644.7324360390438;38847;43883.341749873776;43906.780466097625;43938.34092488611;44012.33981490272;43985.78007109968;44077.55922440783;44289;44478.77760611192;44507.55492445075;8661.220490155869;8796.73609791704;8833.867491987625;8836.955815220947;8908.465492070463;8641.222289993932;8764.123587641217;8769;8772.868406973901;8783.912160878404;8775.341849361323;8829.470231786081;8833.2491738202;8847.646094156225;8847.690330838423;8745.693900713477;8837.602307896128;8839.07189745077;8848.778780530474;8852.203301702813;8740.082291359442;8793.956030219872;8807.471551706918;8820.33847461443;8832.11678832118;34401.311973760385;35392.46911296333;35689;35720.82139589285;35845.46231806525;3388.542546756181;3438.381091403546;3573.908385740078;3619.963800361989;3717.6096509866343;31182;31709.20726981844;31917.8404107978;32073.358532829214;32695.6730432695;4066.674666026711;4087.182563487285;4139.317012692902;4178.770167640779;4260.786960651955;302789;303938;306296;306875;307155;33986.32027359439;34482.65517344794;34578.654213458045;34609.30781384408;34983.65016349855;36373.27253454916;36381.45427818585;36444.45333319949;36461.817690911375;36478.63521364806;15557.29992150356;15829.841701582836;15867.682646347008;15890.284937177854;15908.204589770465;13204.933975330254;13345;13396.129251598615;13426.731465370638;13431.462741490232;8236.876446853303;8257.628406721711;8274.627641756135;8347;8360.205780450848;3143.449896268144;3166.398384306974;3187.298794265258;3190.808551486918;3203.3913556424204;978.6868202175235;1004.2417974429259;1014.832552628808;1047.5757318286107;1090.5801266512292;32690.509642355384;33180;33290.66709332875;33405.66594334074;33876.830615847255;1093.9234253602172;1119.4514687802919;1136.0570726297153;1137.5734099712608;1178.4991378664206;15912.602184945468;16565.337386504645;16825.579360516083;16920.830791692173;17174.828251717572;608832;620252;621660;626554;632321;58455;58850.411495884495;59156.704216479506;59252.70373648104;59453;1334.7797613393682;1350.824392828926;1382.861713828609;1383.764759990804;1401.2083173007218;29936.25159370946;31098.689013110485;31183.064508064796;31303.530447042856;31434.371312573163;51516.227256590435;52056.47943520516;52145;52273;52382.73808630933;511899;521363;524943;526349;526702;27928.720712792612;28531;28559.42881142407;28676.569851452663;28847.278818029718;47929.520704793904;48358.27462588134;48487.27269091037;48751.486325802216;48867.51132488772;41545.376819347126;41825;42049;42503.787481063635;42853;41032;41052.589474104876;42526;42647.14705705931;44669.77665111654;41705.79147104245;41816.58183418127;42301.36547951845;42666;42814;36255.45616815802;38563;38710;38743.41884871673;39098.804505977285;28171.43657126805;28473.43053138967;28687.282817929718;28689.56965645475;29051 02:52:09 INFO - PROCESS | 3444 | |2;jquery.html;375.7595139110969;377.87341240684367;379.7968087073414;387.55431254057845;393.5965635223895;17519.737203941935;19114.42656720299;19744.111514981825;19856.503587410323;19858.106385212664;17483;18419.26322947084;18443.262269509203;19319.323823666175;19332.806671933275;4942.678725882824;4982.676126051813;5095.796168153288;5142.408623008346;5154.123798954187;4961.107000739866;4971.651984361096;5007.799688012475;5057.797688092472;5079.822206222783;5047.873803154932;5059.468755780646;5069.974650126763;5071.670341427795;5082.491750824925;4855.635827312948;4986.526280003394;5029.597632189452;5035.823746168867;5096.821611243608;4764.523547645243;4862;4864.246041863516;4877.6829506081995;4888.608911287089;12123.272603643722;12597.622071337782;12681.048921330937;12686.682832929251;12727.554535591302;2306.7808558186944;2393.628987506939;2502.361897716089;2780.152053623644;2810.901618443345;9223.44659320443;9390.15488606022;9418.811623767555;9423.575939082757;9546.856797148048;1834.385480863912;1852.8054554271741;1901.809819018101;1910.3122875764714;1956.6184594004176;77306;78560.60719696422;79617.60191199064;80912.99999999942;81896.18103818945;8866.33502487316;9267.814643707088;9478.099580539838;10152.086312231786;10570.101541368917;14567.271636418349;14652.413903443956;14712.779308310384;14723.484678036217;14725.779113313309;8026.678932842621;8051.51690898548;8052.872597836307;8085.716999904975;8154.2253485918745;8029.7189598363775;8052.114267430578;8082.757517274374;8125.309348705308;8176.264136227768;4309.116631090682;4321;4451.9554804451545;4488.102379524108;4533.38799262102;1830.5240637434097;1888.4051523769967;1928.3443629166152;1939.2153544443693;1975;943.8018016216535;972.1299437003984;1017.3641474078701;1019.2915923433143;1033.256055639938;18393.264269429073;19191.424257272305;19242.326518571783;19538.511537211398;19577.608447830964;970.1365784451843;987.5950860147449;1023.1098943918689;1061.75048863517;1100.378286268272;10112.949435252776;10789.421553090271;10789.97307474485;10799.78400431987;10843.728906777395;520661;525770;534340;534562;547380;94492.52753736188;98009;98158.5092074535;98863.50568247112;99115.50442247743;999.3703966501058;1034.4569101221919;1055.1084333737979;1056.984145237822;1069.7806949575318;17529.737053944456;17618.29526818913;17716.291348345923;18013.819861801214;18220.36228731988;41251.58748412477;41906.790466047474;42722;43502.782486087366;43844.78077609592;59969;60447.39552604418;60661.696691518024;61942.69028654828;62236;7989.440739148204;8106.432549721463;8206.548639824867;8225.588720563828;8517.616707248064;11953.641390758292;12014.63956081319;12101.515939362327;13400.396982135633;13493.662658433224;10654.8401773975;11203.15976301797;11757;11876.346800926032;11998.220115692453;11643.941780291045;11787.882121178678;11807.173497855068;11989.580364687194;12100.334481603597;11913.702157446132;11945.522179113086;12086.274823510266;12312.13815032939;12332.691682707646;6858;7207.207207207308;7919.485233459806;8121.959390203011;8305.12796156419;10507.264491485828;11249.831252531383;11350.659480215276;11408.94295528517;11497.770044599229 02:52:09 INFO - PROCESS | 3444 | |3;mootools.html;1448.5726710620365;1454.2510607037377;1532.5938626264042;1663.7504374343846;1664.3009935826951;7154.499185057048;7797.376209903208;8334.249917507423;8512.319014478835;8533.061363250037;8448.831023379544;8474.576271186446;8478.491290522574;8547.10255423181;8556;2232.241038047068;2250.1449449209276;2260.9208677696283;2266.9319920402413;2267.5238199977944;2200.4058904095887;2225.1544413122992;2294.0479700924097;2295.2655150351893;2299.839011269212;2219.056900817154;2234.181586885121;2261.1746712450004;2267.2291420916886;2293.1859189987563;2164.8701077935298;2176;2184.2682701295007;2191.3097374327035;2195.2755590655047;2158.2769772126358;2165.523584811355;2165.72928383952;2167.729033870766;2168.3711723600136;8410.36922230829;8432.325413966868;8506.31949444043;8509.829803403898;8522.914770852274;4734.786934587917;4815.916418805776;4816.08494386069;4824.372831531879;4842.370491836074;3112.6264848218134;3120.1419609607315;3121.4693502104697;3137.2470607054142;3141.4502462069277;1040.6825918094978;1052.5631862776938;1070;1079.4440862955585;1081.7566047639218;11076.39079850608;11117.888821111766;11151.888481115166;11193.832092518618;11201.159913006557;4187.14163596462;4282.914341713211;4338.154059958278;4355.1725172217175;4357.302831546937;9452.338336316392;9458.810823783624;9525.476098814632;9567.425954442755;9603.807923841485;4794.2808578712775;4814.133455977888;4820.734859582757;4826.420829500412;4828.155072862235;4060.5127384713433;4477.619402350837;4487.483939346952;4623.69945953512;4653.906921861544;3860.613938606173;3863.74885632433;4001.139754952699;4006.1186538961383;4010.9197816043516;1191.7676053169723;1212.4483360071147;1217.5738491527895;1218.4334284557547;1222.1689251309017;803.9115697273295;949.7293271417751;959.64972784933;963.7686955130858;968.4286271100085;5423.430539793344;5725.198472213893;5751.309842818889;5818.7672493100645;5944.7324870380935;952.2715122930963;973.4159504297365;983.1299300119302;1001.3140998416109;1010.545254635417;3722.553293604785;3840;3882.068303607114;3896.2207558488417;3963.365861462152;9697.466639334763;9715.319927605;9823.656172034087;9923.900760992297;9938;9709.126178643955;9714.854277185848;9774.51127443625;10227.590896364061;10269.537870795832;7962;8046.718364857202;8100.959495202605;8154.429189956765;8164.306033987059;5725.656460612377;5784.82645520635;5838.970805145947;6123.693815309306;6203;8997.505137217255;9148.170365926708;9376.156145946898;9719.951400242953;9730.27022973294;9801.705948821547;9858.457784821616;9864.654737084167;10119.139873110573;10348.172146228435;7109.928900710926;7580;7859.724909628136;8170.305524030524;8361.498310101413;8058.83882322362;8072.677092916218;8081.393895457747;8169.918300816916;8178.959105204436;6834.965825170842;7060.576365417885;7170.820729481596;7182.60495672743;7308.415326773739;7011.1586609607175;7125.3230943060325;7202.783916482514;7214.819629509304;7268.27317268269;7070.116235470567;7149.82125446868;7181.856362872818;7184.030155929092;7191.4246860250005;4889.975550122226;5001.749912504288;5055.747212639427;5072.4673909239;5182.32629758129;4962.082014827269;5080.466551012239;5113.974430127825;5149.897002060013;5169.870753231049 02:52:09 INFO - PROCESS | 3444 | |4;prototype.html;269.15351220411793;281.81541090585665;283.7999210556557;284.3914023988663;287.99280017999547;5411.512963833255;5516.779328826842;5614.410486898873;5668.121441176624;5670.8015219467325;5518.530924871381;5527.889442211153;5568.721563921808;5580.274564306645;5580.609357344987;4195.594475850594;4197.391378250152;4214.4099826024385;4216.894577635553;4223.577642235768;4018.537868145157;4194.3498757692605;4216.093539888923;4231.978840105795;4255.702100852942;4136.834526618932;4159.688023398242;4168.228877657628;4170.103427763031;4188.492142828579;4191.266528357556;4192.643625291854;4215.199112168693;4221.620054195107;4228.577142285778;3648;3660.359437098497;3673.834677439522;3678.411454167347;3693;5176.430592634807;5332.546733527654;5424;5429.918551221735;5431.185322201702;4707.199776038082;4735.857924262277;4741.834035808764;4751.263554149113;4784.44032442645;5511.889762204773;5779.913301300484;5796.652200867961;5801.7389217485315;5819.330776960619;3889.2610404023426;3895.7272990890647;3909.354956432185;3923.117298607819;3928.64642182205;6075.817725468199;6078.331383547807;6082.270127584674;6100.206973093514;6125.142480052797;3884.7086468514976;3990.2618015667194;4002.8398864045694;4028.013136781449;4029.294873397144;3940.113474468279;3971.3050216212046;3980.4626375439525;3985.92028159441;4003.959960400417;4693.413323334583;4693.624510039189;4701.388819453449;4725.243960966298;4730;5607.467290607386;5837.3287071986415;5910.172575839386;5925.318588362394;5970.58205925581;1363.8158848555518;1364.7543442180304;1384.349355802771;1389.2567476400077;1391.958241252764;831.5925196653717;848.240824462103;854.2013217641525;866.5537248317122;868.769776009358;4973.875653108701;5026.447090820006;5048.848534543969;5055.974720126449;5082.720450375191;5334.453008627532;5348.973255133699;5374.704391258519;5376.327959005124;5376.489233522809;4650.37219975299;5048.671836330626;5070.61970352225;5110.361204849394;5116.283720279164;2853.315204350982;2889.971100289012;2912.796104272723;2923.5760814681753;2933.6919623439658;5456.03582710224;5544.3346798383645;5544.805931792368;5548.167774833726;5554.555815488002;5150.982991483539;5369.624126311199;5455.563554915597;5458.536024437888;5540.36285827135;5424.538914192338;5517.889642207133;5533.557315414757;5555.250041244381;5555.861048485051;5052.9285824280905;5301;5351.491608297206;5371.301730774974;5427.457254274541;5082.390113186441;5243.318368612056;5248.475152484873;5259.316288882421;5351.5451186648015;5451.291332126957;5541.4483944495605;5542.307211598551;5563.193336966036;5599.412061733459;3613.747037707335;3651.9269614608093;3666.7066634668627;3674.273091646922;3693.4118329118737;5645.774169033357;5805.216295800013;5935.673537955454;6048.758049677964;6055.666938318434;5909.23179986599;5925.229720136354;5944.970275148597;5947.851303717269;5964.091490723101;5861;5891;5891.558133139946;5913.970430147821;5916.674582897982;5623.803166889139;5822.94177058224;5825.621334613236;5837.270341207349;5841.561882858888;5907.143464197753;5965.135055416853;5967.49276311501;5988.461038506555;5992.370801065826;5683.943160568507;5782.537397008314;5786.971065144648;5804.709764511842;5806.200077975841 02:52:09 INFO - PROCESS | 3444 | |5;yui.html;740.4816628360143;772.1544908325382;795.8169620987172;795.9124496305407;820.2125959079284;15144.318505667245;16121.193940302997;16169.27238274279;16224.756628650564;16623.08573028483;15552.688946221097;16233.756493652605;16239.025658460501;16323.34706611737;16365.59086022847;655.4919937048778;791.9841603167947;795.9641816118288;797.6291024673526;798.0184373220942;771.2750014985924;794.6821271491392;797.8962734844462;799.4883274704165;800.5356893002045;822.5023860564362;827.8551253530608;828.5235989306143;831.2061980808344;833.3291700181352;824.5918270456102;825.6037102190921;827.4084029918607;828.7223780033665;831.0484495252902;596.2993482657903;596.749365266589;600.1897438458091;602.8402473344568;603.9154518367432;15348.309326080353;15427.30577124032;15516.379344826193;15526.068435893769;15569.37722491099;14915.254237288093;14943.775843362359;14971.176585287805;15030.924845375812;15076.698466030617;12366.083257095164;12400.13199076065;12504.187227830253;12667.30329831859;12747.42636581356;3647.2340808430263;3655.762375445614;3715.3869611514338;3747.156889699823;3843.327417701891;77523;78000.60999694966;78673.60663196647;79676;79901;11176.944115279372;11309.886901131047;11616.825747613793;11621.07031437483;11842.88157118435;20908.89545552293;21403.67894481584;21536;21576;21589.13643454244;8830;8880.733577992542;9055.637774489078;9070.773230669154;9167.220786233245;4734.597559207506;4740.834070807574;4811.807527698853;5002.224655178453;5058.822941197041;3743.1016556026902;3830.0233440472502;3849.287881741887;3856.73002889795;3858.6527212551005;638.1385130074362;641.9518536109717;643.6266965160289;644.22049320322;661.7022339947043;617.200725061047;620.4354037825557;637.7066549387333;741.0736579275905;757.8522188173364;10058.47368684095;10370.896291037145;10662.41356725372;10888.836667449994;11238;606.1937622961451;645.6642545876118;685.4961603221628;734.1153909538992;763.8579283697385;4830.758462076882;5007.524285192901;5083.313752643346;5251.422343542207;5294.814681486129;105130.47434762931;107007;107270;109211.45394272977;110112.4494377539;99309.50345248227;103020;103156;103649;104381.47809261057;84078.5796071028;87857.56071219732;89092.9999999987;89893;91568;9177.36376804366;9195.402298850553;9195.77010574741;9301.72094837156;9469;49499.50500494949;49715.25427118524;51180.74409628077;51278.230826538376;52497;67789.3221067783;72632;73152.26847731454;73760;74303.68418684472;12607.306598137191;12742.980561554868;12777.169483983884;12855.742885142057;13356.866431335951;13972.37124329428;13990.300484975507;14033.508827190999;14101;14313.069650472686;12852.614421567368;12988.545400910923;13259;13296.933515332748;13833.86166138366;12268.386580670753;12422;13173.40719667598;13262.867371326549;13374.665633359244;11514;13363.933180334036;13368.933155334162;13573.11774734639;13816.309184540934;11488.655340339803;11503.942480287546;11522.481488333213;11539.88460115388;11783.410829458322;11021.393823339793;11199.552017919192;11393.695828209726;11957.222780519238;12116.75766484683 02:52:09 INFO - PROCESS | 3444 | __end_tp_report 02:52:09 INFO - PROCESS | 3444 | __start_cc_report 02:52:09 INFO - PROCESS | 3444 | _x_x_mozilla_cycle_collect,350 02:52:09 INFO - PROCESS | 3444 | __end_cc_report 02:52:09 INFO - PROCESS | 3444 | __startTimestamp1466675529869__endTimestamp 02:52:09 INFO - PROCESS | 3444 | 02:52:09 INFO - PROCESS | 3444 | ------- Summary: start ------- 02:52:09 INFO - PROCESS | 3444 | Number of tests: 6 02:52:09 INFO - PROCESS | 3444 | 02:52:09 INFO - PROCESS | 3444 | [#0] dojo.html Cycles:165 Average:5407.04 Median:5613.89 stddev:624.17 (11.1%) stddev-sans-first:598.76 02:52:09 INFO - PROCESS | 3444 | Values: 3078.5 3093.4 3130.6 3137.2 3144.4 5336.4 5354.6 5424.5 5444.9 5451.1 5279.9 5343.2 5347.8 5439.8 5459.7 4797.6 4821.1 4861.7 4973.4 5007.8 4821.3 5069.4 5084.8 5085.6 5094.4 4842.4 4894.2 4919.6 4971.0 4999.1 4928.2 4940.2 4941.6 4943.2 4998.8 4926.8 4927.8 4944.1 4949.2 4969.1 5228.8 5397.4 5411.1 5458.4 5490.3 5799.2 5817.8 5828.9 5832.3 5859.9 5610.8 5911.8 5917.3 5918.4 5923.5 5388.2 5417.2 5418.4 5419.8 5426.2 5882.7 5891.4 5891.9 5901.2 5906.4 5613.9 5652.2 5655.8 5659.5 5735.8 5859.0 5885.0 5898.4 5918.2 5937.9 5541.9 5733.4 5842.3 5884.4 5912.9 5546.3 5741.1 5793.2 5800.5 5802.8 4388.7 4404.6 4425.5 4427.4 4457.4 3934.9 3956.8 3962.7 3969.0 3982.8 5457.9 5497.2 5524.9 5564.5 5600.8 5925.1 5942.4 5947.0 5958.2 5985.2 5641.3 5650.8 5667.5 5668.5 5674.0 4902.4 4992.3 5003.2 5035.3 5086.7 6022.4 6026.4 6029.0 6037.5 6042.2 5800.8 5807.9 5810.9 5829.3 5832.0 5870.0 5969.8 5990.5 6034.1 6072.5 5736.3 5747.6 5749.6 5759.3 5770.5 5705.9 5864.6 5874.4 5879.6 5882.2 5537.6 5734.1 5756.9 5780.1 5781.5 5556.6 5576.9 5663.3 5674.5 5692.4 5587.8 5595.8 5598.5 5603.9 5604.5 5535.1 5741.4 5754.7 5818.6 5823.9 5672.3 5681.5 5682.4 5684.8 5700.2 02:52:09 INFO - PROCESS | 3444 | 02:52:09 INFO - PROCESS | 3444 | [#1] ext.html Cycles:180 Average:62063.63 Median:4076.93 stddev:134030.59 (3287.5%) stddev-sans-first:134327.10 02:52:09 INFO - PROCESS | 3444 | Values: 585.9 606.8 615.8 640.8 644.7 38847.0 43883.3 43906.8 43938.3 44012.3 43985.8 44077.6 44289.0 44478.8 44507.6 8661.2 8796.7 8833.9 8837.0 8908.5 8641.2 8764.1 8769.0 8772.9 8783.9 8775.3 8829.5 8833.2 8847.6 8847.7 8745.7 8837.6 8839.1 8848.8 8852.2 8740.1 8794.0 8807.5 8820.3 8832.1 34401.3 35392.5 35689.0 35720.8 35845.5 3388.5 3438.4 3573.9 3620.0 3717.6 31182.0 31709.2 31917.8 32073.4 32695.7 4066.7 4087.2 4139.3 4178.8 4260.8 302789.0 303938.0 306296.0 306875.0 307155.0 33986.3 34482.7 34578.7 34609.3 34983.7 36373.3 36381.5 36444.5 36461.8 36478.6 15557.3 15829.8 15867.7 15890.3 15908.2 13204.9 13345.0 13396.1 13426.7 13431.5 8236.9 8257.6 8274.6 8347.0 8360.2 3143.4 3166.4 3187.3 3190.8 3203.4 978.7 1004.2 1014.8 1047.6 1090.6 32690.5 33180.0 33290.7 33405.7 33876.8 1093.9 1119.5 1136.1 1137.6 1178.5 15912.6 16565.3 16825.6 16920.8 17174.8 608832.0 620252.0 621660.0 626554.0 632321.0 58455.0 58850.4 59156.7 59252.7 59453.0 1334.8 1350.8 1382.9 1383.8 1401.2 29936.3 31098.7 31183.1 31303.5 31434.4 51516.2 52056.5 52145.0 52273.0 52382.7 511899.0 521363.0 524943.0 526349.0 526702.0 27928.7 28531.0 28559.4 28676.6 28847.3 47929.5 48358.3 48487.3 48751.5 48867.5 41545.4 41825.0 42049.0 42503.8 42853.0 41032.0 41052.6 42526.0 42647.1 44669.8 41705.8 41816.6 42301.4 42666.0 42814.0 36255.5 38563.0 38710.0 38743.4 39098.8 28171.4 28473.4 28687.3 28689.6 29051.0 02:52:09 INFO - PROCESS | 3444 | 02:52:09 INFO - PROCESS | 3444 | [#2] jquery.html Cycles:180 Average:29888.77 Median:390.58 stddev:87830.71 (22487.5%) stddev-sans-first:88049.14 02:52:09 INFO - PROCESS | 3444 | Values: 375.8 377.9 379.8 387.6 393.6 17519.7 19114.4 19744.1 19856.5 19858.1 17483.0 18419.3 18443.3 19319.3 19332.8 4942.7 4982.7 5095.8 5142.4 5154.1 4961.1 4971.7 5007.8 5057.8 5079.8 5047.9 5059.5 5070.0 5071.7 5082.5 4855.6 4986.5 5029.6 5035.8 5096.8 4764.5 4862.0 4864.2 4877.7 4888.6 12123.3 12597.6 12681.0 12686.7 12727.6 2306.8 2393.6 2502.4 2780.2 2810.9 9223.4 9390.2 9418.8 9423.6 9546.9 1834.4 1852.8 1901.8 1910.3 1956.6 77306.0 78560.6 79617.6 80913.0 81896.2 8866.3 9267.8 9478.1 10152.1 10570.1 14567.3 14652.4 14712.8 14723.5 14725.8 8026.7 8051.5 8052.9 8085.7 8154.2 8029.7 8052.1 8082.8 8125.3 8176.3 4309.1 4321.0 4452.0 4488.1 4533.4 1830.5 1888.4 1928.3 1939.2 1975.0 943.8 972.1 1017.4 1019.3 1033.3 18393.3 19191.4 19242.3 19538.5 19577.6 970.1 987.6 1023.1 1061.8 1100.4 10112.9 10789.4 10790.0 10799.8 10843.7 520661.0 525770.0 534340.0 534562.0 547380.0 94492.5 98009.0 98158.5 98863.5 99115.5 999.4 1034.5 1055.1 1057.0 1069.8 17529.7 17618.3 17716.3 18013.8 18220.4 41251.6 41906.8 42722.0 43502.8 43844.8 59969.0 60447.4 60661.7 61942.7 62236.0 7989.4 8106.4 8206.5 8225.6 8517.6 11953.6 12014.6 12101.5 13400.4 13493.7 10654.8 11203.2 11757.0 11876.3 11998.2 11643.9 11787.9 11807.2 11989.6 12100.3 11913.7 11945.5 12086.3 12312.1 12332.7 6858.0 7207.2 7919.5 8122.0 8305.1 10507.3 11249.8 11350.7 11408.9 11497.8 02:52:09 INFO - PROCESS | 3444 | 02:52:09 INFO - PROCESS | 3444 | [#3] mootools.html Cycles:180 Average:5508.41 Median:5076.47 stddev:3070.65 (60.5%) stddev-sans-first:3064.10 02:52:09 INFO - PROCESS | 3444 | Values: 1448.6 1454.3 1532.6 1663.8 1664.3 7154.5 7797.4 8334.2 8512.3 8533.1 8448.8 8474.6 8478.5 8547.1 8556.0 2232.2 2250.1 2260.9 2266.9 2267.5 2200.4 2225.2 2294.0 2295.3 2299.8 2219.1 2234.2 2261.2 2267.2 2293.2 2164.9 2176.0 2184.3 2191.3 2195.3 2158.3 2165.5 2165.7 2167.7 2168.4 8410.4 8432.3 8506.3 8509.8 8522.9 4734.8 4815.9 4816.1 4824.4 4842.4 3112.6 3120.1 3121.5 3137.2 3141.5 1040.7 1052.6 1070.0 1079.4 1081.8 11076.4 11117.9 11151.9 11193.8 11201.2 4187.1 4282.9 4338.2 4355.2 4357.3 9452.3 9458.8 9525.5 9567.4 9603.8 4794.3 4814.1 4820.7 4826.4 4828.2 4060.5 4477.6 4487.5 4623.7 4653.9 3860.6 3863.7 4001.1 4006.1 4010.9 1191.8 1212.4 1217.6 1218.4 1222.2 803.9 949.7 959.6 963.8 968.4 5423.4 5725.2 5751.3 5818.8 5944.7 952.3 973.4 983.1 1001.3 1010.5 3722.6 3840.0 3882.1 3896.2 3963.4 9697.5 9715.3 9823.7 9923.9 9938.0 9709.1 9714.9 9774.5 10227.6 10269.5 7962.0 8046.7 8101.0 8154.4 8164.3 5725.7 5784.8 5839.0 6123.7 6203.0 8997.5 9148.2 9376.2 9720.0 9730.3 9801.7 9858.5 9864.7 10119.1 10348.2 7109.9 7580.0 7859.7 8170.3 8361.5 8058.8 8072.7 8081.4 8169.9 8179.0 6835.0 7060.6 7170.8 7182.6 7308.4 7011.2 7125.3 7202.8 7214.8 7268.3 7070.1 7149.8 7181.9 7184.0 7191.4 4890.0 5001.7 5055.7 5072.5 5182.3 4962.1 5080.5 5114.0 5149.9 5169.9 02:52:09 INFO - PROCESS | 3444 | 02:52:09 INFO - PROCESS | 3444 | [#4] prototype.html Cycles:180 Average:4672.00 Median:5350.23 stddev:1418.31 (26.5%) stddev-sans-first:1383.25 02:52:09 INFO - PROCESS | 3444 | Values: 269.2 281.8 283.8 284.4 288.0 5411.5 5516.8 5614.4 5668.1 5670.8 5518.5 5527.9 5568.7 5580.3 5580.6 4195.6 4197.4 4214.4 4216.9 4223.6 4018.5 4194.3 4216.1 4232.0 4255.7 4136.8 4159.7 4168.2 4170.1 4188.5 4191.3 4192.6 4215.2 4221.6 4228.6 3648.0 3660.4 3673.8 3678.4 3693.0 5176.4 5332.5 5424.0 5429.9 5431.2 4707.2 4735.9 4741.8 4751.3 4784.4 5511.9 5779.9 5796.7 5801.7 5819.3 3889.3 3895.7 3909.4 3923.1 3928.6 6075.8 6078.3 6082.3 6100.2 6125.1 3884.7 3990.3 4002.8 4028.0 4029.3 3940.1 3971.3 3980.5 3985.9 4004.0 4693.4 4693.6 4701.4 4725.2 4730.0 5607.5 5837.3 5910.2 5925.3 5970.6 1363.8 1364.8 1384.3 1389.3 1392.0 831.6 848.2 854.2 866.6 868.8 4973.9 5026.4 5048.8 5056.0 5082.7 5334.5 5349.0 5374.7 5376.3 5376.5 4650.4 5048.7 5070.6 5110.4 5116.3 2853.3 2890.0 2912.8 2923.6 2933.7 5456.0 5544.3 5544.8 5548.2 5554.6 5151.0 5369.6 5455.6 5458.5 5540.4 5424.5 5517.9 5533.6 5555.3 5555.9 5052.9 5301.0 5351.5 5371.3 5427.5 5082.4 5243.3 5248.5 5259.3 5351.5 5451.3 5541.4 5542.3 5563.2 5599.4 3613.7 3651.9 3666.7 3674.3 3693.4 5645.8 5805.2 5935.7 6048.8 6055.7 5909.2 5925.2 5945.0 5947.9 5964.1 5861.0 5891.0 5891.6 5914.0 5916.7 5623.8 5822.9 5825.6 5837.3 5841.6 5907.1 5965.1 5967.5 5988.5 5992.4 5683.9 5782.5 5787.0 5804.7 5806.2 02:52:09 INFO - PROCESS | 3444 | 02:52:09 INFO - PROCESS | 3444 | [#5] yui.html Cycles:180 Average:20870.71 Median:3846.31 stddev:29703.59 (772.3%) stddev-sans-first:29748.46 02:52:09 INFO - PROCESS | 3444 | Values: 740.5 772.2 795.8 795.9 820.2 15144.3 16121.2 16169.3 16224.8 16623.1 15552.7 16233.8 16239.0 16323.3 16365.6 655.5 792.0 796.0 797.6 798.0 771.3 794.7 797.9 799.5 800.5 822.5 827.9 828.5 831.2 833.3 824.6 825.6 827.4 828.7 831.0 596.3 596.7 600.2 602.8 603.9 15348.3 15427.3 15516.4 15526.1 15569.4 14915.3 14943.8 14971.2 15030.9 15076.7 12366.1 12400.1 12504.2 12667.3 12747.4 3647.2 3655.8 3715.4 3747.2 3843.3 77523.0 78000.6 78673.6 79676.0 79901.0 11176.9 11309.9 11616.8 11621.1 11842.9 20908.9 21403.7 21536.0 21576.0 21589.1 8830.0 8880.7 9055.6 9070.8 9167.2 4734.6 4740.8 4811.8 5002.2 5058.8 3743.1 3830.0 3849.3 3856.7 3858.7 638.1 642.0 643.6 644.2 661.7 617.2 620.4 637.7 741.1 757.9 10058.5 10370.9 10662.4 10888.8 11238.0 606.2 645.7 685.5 734.1 763.9 4830.8 5007.5 5083.3 5251.4 5294.8 105130.5 107007.0 107270.0 109211.5 110112.4 99309.5 103020.0 103156.0 103649.0 104381.5 84078.6 87857.6 89093.0 89893.0 91568.0 9177.4 9195.4 9195.8 9301.7 9469.0 49499.5 49715.3 51180.7 51278.2 52497.0 67789.3 72632.0 73152.3 73760.0 74303.7 12607.3 12743.0 12777.2 12855.7 13356.9 13972.4 13990.3 14033.5 14101.0 14313.1 12852.6 12988.5 13259.0 13296.9 13833.9 12268.4 12422.0 13173.4 13262.9 13374.7 11514.0 13363.9 13368.9 13573.1 13816.3 11488.7 11503.9 11522.5 11539.9 11783.4 11021.4 11199.6 11393.7 11957.2 12116.8 02:52:09 INFO - PROCESS | 3444 | -------- Summary: end -------- 02:52:09 INFO - PROCESS | 3444 | 02:52:10 INFO - TEST-INFO | 3444: exit 0 02:52:10 INFO - TEST-OK | dromaeo_css | took 1112523ms 02:52:10 INFO - TEST-START | kraken 02:52:10 INFO - operating with platform_type : linux_ 02:52:10 INFO - Initialising browser for kraken test... 02:52:10 INFO - TEST-INFO | started process 3712 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZpwhiX/profile http://localhost:54786/getInfo.html) 02:52:15 INFO - PROCESS | 3712 | __metrics Screen width/height:1600/1200 02:52:15 INFO - PROCESS | 3712 | colorDepth:24 02:52:15 INFO - PROCESS | 3712 | Browser inner width/height: 1024/697 02:52:15 INFO - PROCESS | 3712 | __metrics 02:52:16 ERROR - PROCESS | 3712 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 02:52:17 INFO - TEST-INFO | 3712: exit 0 02:52:17 INFO - Browser initialized. 02:52:17 INFO - Running cycle 1/1 for kraken test... 02:52:17 INFO - TEST-INFO | started process 3832 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZpwhiX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:52:29 INFO - PROCESS | 3832 | RSS: Main: 185479168 02:52:29 INFO - PROCESS | 3832 | 02:52:31 INFO - PROCESS | 3832 | Cycle 1(1): loaded http://localhost:54786/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54786/tests/kraken/driver.html?testName=audio-beat-detection) 02:52:32 INFO - PROCESS | 3832 | RSS: Main: 190996480 02:52:32 INFO - PROCESS | 3832 | 02:52:35 INFO - PROCESS | 3832 | Cycle 1(1): loaded http://localhost:54786/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54786/tests/kraken/driver.html?testName=audio-dft) 02:52:35 INFO - PROCESS | 3832 | RSS: Main: 190169088 02:52:35 INFO - PROCESS | 3832 | 02:52:38 INFO - PROCESS | 3832 | Cycle 1(1): loaded http://localhost:54786/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54786/tests/kraken/driver.html?testName=audio-fft) 02:52:39 INFO - PROCESS | 3832 | RSS: Main: 185307136 02:52:39 INFO - PROCESS | 3832 | 02:52:41 INFO - PROCESS | 3832 | Cycle 1(1): loaded http://localhost:54786/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54786/tests/kraken/driver.html?testName=audio-oscillator) 02:52:42 INFO - PROCESS | 3832 | RSS: Main: 185978880 02:52:42 INFO - PROCESS | 3832 | 02:52:44 INFO - PROCESS | 3832 | Cycle 1(1): loaded http://localhost:54786/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54786/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:52:44 INFO - PROCESS | 3832 | RSS: Main: 186101760 02:52:44 INFO - PROCESS | 3832 | 02:52:48 INFO - PROCESS | 3832 | Cycle 1(1): loaded http://localhost:54786/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54786/tests/kraken/driver.html?testName=imaging-darkroom) 02:52:48 INFO - PROCESS | 3832 | RSS: Main: 185774080 02:52:48 INFO - PROCESS | 3832 | 02:52:52 INFO - PROCESS | 3832 | Cycle 1(1): loaded http://localhost:54786/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54786/tests/kraken/driver.html?testName=imaging-desaturate) 02:52:52 INFO - PROCESS | 3832 | RSS: Main: 184250368 02:52:52 INFO - PROCESS | 3832 | 02:52:55 INFO - PROCESS | 3832 | Cycle 1(1): loaded http://localhost:54786/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54786/tests/kraken/driver.html?testName=json-parse-financial) 02:52:56 INFO - PROCESS | 3832 | RSS: Main: 185815040 02:52:56 INFO - PROCESS | 3832 | 02:52:57 INFO - PROCESS | 3832 | Cycle 1(1): loaded http://localhost:54786/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54786/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:52:58 INFO - PROCESS | 3832 | RSS: Main: 186613760 02:52:58 INFO - PROCESS | 3832 | 02:53:00 INFO - PROCESS | 3832 | Cycle 1(1): loaded http://localhost:54786/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54786/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:53:00 INFO - PROCESS | 3832 | RSS: Main: 186564608 02:53:00 INFO - PROCESS | 3832 | 02:53:02 INFO - PROCESS | 3832 | Cycle 1(1): loaded http://localhost:54786/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54786/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:53:03 INFO - PROCESS | 3832 | RSS: Main: 187019264 02:53:03 INFO - PROCESS | 3832 | 02:53:06 INFO - PROCESS | 3832 | Cycle 1(1): loaded http://localhost:54786/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54786/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:53:06 INFO - PROCESS | 3832 | RSS: Main: 187633664 02:53:06 INFO - PROCESS | 3832 | 02:53:09 INFO - PROCESS | 3832 | Cycle 1(1): loaded http://localhost:54786/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54786/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:53:10 INFO - PROCESS | 3832 | RSS: Main: 186646528 02:53:10 INFO - PROCESS | 3832 | 02:53:11 INFO - PROCESS | 3832 | Cycle 1(1): loaded http://localhost:54786/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54786/tests/kraken/driver.html?testName=ai-astar) 02:53:12 INFO - PROCESS | 3832 | RSS: Main: 188129280 02:53:12 INFO - PROCESS | 3832 | 02:53:12 INFO - PROCESS | 3832 | __start_tp_report 02:53:12 INFO - PROCESS | 3832 | _x_x_mozilla_page_load 02:53:12 INFO - PROCESS | 3832 | _x_x_mozilla_page_load_details 02:53:12 INFO - PROCESS | 3832 | |i|pagename|runs| 02:53:12 INFO - PROCESS | 3832 | |0;ai-astar;102;111;105;113;112;111;112;110;112;114 02:53:12 INFO - PROCESS | 3832 | |1;audio-beat-detection;153;130;151;179;136;173;156;129;183;127 02:53:12 INFO - PROCESS | 3832 | |2;audio-dft;161;161;163;163;168;173;163;162;161;168 02:53:12 INFO - PROCESS | 3832 | |3;audio-fft;76;75;76;168;75;75;75;75;162;77 02:53:12 INFO - PROCESS | 3832 | |4;audio-oscillator;84;85;149;85;86;85;142;85;86;145 02:53:12 INFO - PROCESS | 3832 | |5;imaging-gaussian-blur;118;118;117;118;118;119;119;117;118;117 02:53:12 INFO - PROCESS | 3832 | |6;imaging-darkroom;148;151;147;148;148;147;147;148;147;148 02:53:12 INFO - PROCESS | 3832 | |7;imaging-desaturate;95;97;96;95;97;96;96;96;96;96 02:53:12 INFO - PROCESS | 3832 | |8;json-parse-financial;57;57;55;55;55;55;55;58;56;55 02:53:12 INFO - PROCESS | 3832 | |9;json-stringify-tinderbox;62;62;63;61;70;61;61;61;62;62 02:53:12 INFO - PROCESS | 3832 | |10;stanford-crypto-aes;79;84;80;84;79;86;81;81;103;81 02:53:12 INFO - PROCESS | 3832 | |11;stanford-crypto-ccm;129;123;122;122;123;132;128;135;131;129 02:53:12 INFO - PROCESS | 3832 | |12;stanford-crypto-pbkdf2;163;157;165;162;162;164;163;163;162;159 02:53:12 INFO - PROCESS | 3832 | |13;stanford-crypto-sha256-iterative;63;63;62;63;66;62;67;62;61;66 02:53:12 INFO - PROCESS | 3832 | __end_tp_report 02:53:12 INFO - PROCESS | 3832 | __start_cc_report 02:53:12 INFO - PROCESS | 3832 | _x_x_mozilla_cycle_collect,893 02:53:12 INFO - PROCESS | 3832 | __end_cc_report 02:53:12 INFO - PROCESS | 3832 | __startTimestamp1466675592158__endTimestamp 02:53:12 INFO - PROCESS | 3832 | 02:53:12 INFO - PROCESS | 3832 | ------- Summary: start ------- 02:53:12 INFO - PROCESS | 3832 | Number of tests: 14 02:53:12 INFO - PROCESS | 3832 | 02:53:12 INFO - PROCESS | 3832 | [#0] ai-astar Cycles:10 Average:110.20 Median:112.00 stddev:3.77 (3.4%) stddev-sans-first:2.57 02:53:12 INFO - PROCESS | 3832 | Values: 102.0 111.0 105.0 113.0 112.0 111.0 112.0 110.0 112.0 114.0 02:53:12 INFO - PROCESS | 3832 | 02:53:12 INFO - PROCESS | 3832 | [#1] audio-beat-detection Cycles:10 Average:151.70 Median:154.50 stddev:21.19 (13.7%) stddev-sans-first:22.47 02:53:12 INFO - PROCESS | 3832 | Values: 153.0 130.0 151.0 179.0 136.0 173.0 156.0 129.0 183.0 127.0 02:53:12 INFO - PROCESS | 3832 | 02:53:12 INFO - PROCESS | 3832 | [#2] audio-dft Cycles:10 Average:164.30 Median:163.00 stddev:4.03 (2.5%) stddev-sans-first:4.09 02:53:12 INFO - PROCESS | 3832 | Values: 161.0 161.0 163.0 163.0 168.0 173.0 163.0 162.0 161.0 168.0 02:53:12 INFO - PROCESS | 3832 | 02:53:12 INFO - PROCESS | 3832 | [#3] audio-fft Cycles:10 Average:93.40 Median:75.00 stddev:37.77 (50.4%) stddev-sans-first:39.53 02:53:12 INFO - PROCESS | 3832 | Values: 76.0 75.0 76.0 168.0 75.0 75.0 75.0 75.0 162.0 77.0 02:53:12 INFO - PROCESS | 3832 | 02:53:12 INFO - PROCESS | 3832 | [#4] audio-oscillator Cycles:10 Average:103.20 Median:85.00 stddev:29.13 (34.3%) stddev-sans-first:30.05 02:53:12 INFO - PROCESS | 3832 | Values: 84.0 85.0 149.0 85.0 86.0 85.0 142.0 85.0 86.0 145.0 02:53:12 INFO - PROCESS | 3832 | 02:53:12 INFO - PROCESS | 3832 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 02:53:12 INFO - PROCESS | 3832 | Values: 118.0 118.0 117.0 118.0 118.0 119.0 119.0 117.0 118.0 117.0 02:53:12 INFO - PROCESS | 3832 | 02:53:12 INFO - PROCESS | 3832 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:1.20 (0.8%) stddev-sans-first:1.27 02:53:12 INFO - PROCESS | 3832 | Values: 148.0 151.0 147.0 148.0 148.0 147.0 147.0 148.0 147.0 148.0 02:53:12 INFO - PROCESS | 3832 | 02:53:12 INFO - PROCESS | 3832 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 02:53:12 INFO - PROCESS | 3832 | Values: 95.0 97.0 96.0 95.0 97.0 96.0 96.0 96.0 96.0 96.0 02:53:12 INFO - PROCESS | 3832 | 02:53:12 INFO - PROCESS | 3832 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:55.50 stddev:1.14 (2.0%) stddev-sans-first:1.12 02:53:12 INFO - PROCESS | 3832 | Values: 57.0 57.0 55.0 55.0 55.0 55.0 55.0 58.0 56.0 55.0 02:53:12 INFO - PROCESS | 3832 | 02:53:12 INFO - PROCESS | 3832 | [#9] json-stringify-tinderbox Cycles:10 Average:62.50 Median:62.00 stddev:2.72 (4.4%) stddev-sans-first:2.88 02:53:12 INFO - PROCESS | 3832 | Values: 62.0 62.0 63.0 61.0 70.0 61.0 61.0 61.0 62.0 62.0 02:53:12 INFO - PROCESS | 3832 | 02:53:12 INFO - PROCESS | 3832 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:81.00 stddev:7.13 (8.8%) stddev-sans-first:7.35 02:53:12 INFO - PROCESS | 3832 | Values: 79.0 84.0 80.0 84.0 79.0 86.0 81.0 81.0 103.0 81.0 02:53:12 INFO - PROCESS | 3832 | 02:53:12 INFO - PROCESS | 3832 | [#11] stanford-crypto-ccm Cycles:10 Average:127.40 Median:129.00 stddev:4.65 (3.6%) stddev-sans-first:4.89 02:53:12 INFO - PROCESS | 3832 | Values: 129.0 123.0 122.0 122.0 123.0 132.0 128.0 135.0 131.0 129.0 02:53:12 INFO - PROCESS | 3832 | 02:53:12 INFO - PROCESS | 3832 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.00 Median:163.00 stddev:2.36 (1.4%) stddev-sans-first:2.47 02:53:12 INFO - PROCESS | 3832 | Values: 163.0 157.0 165.0 162.0 162.0 164.0 163.0 163.0 162.0 159.0 02:53:12 INFO - PROCESS | 3832 | 02:53:12 INFO - PROCESS | 3832 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:63.00 stddev:2.07 (3.3%) stddev-sans-first:2.19 02:53:12 INFO - PROCESS | 3832 | Values: 63.0 63.0 62.0 63.0 66.0 62.0 67.0 62.0 61.0 66.0 02:53:12 INFO - PROCESS | 3832 | -------- Summary: end -------- 02:53:12 INFO - PROCESS | 3832 | 02:53:13 INFO - TEST-INFO | 3832: exit 0 02:53:13 INFO - TEST-OK | kraken | took 62462ms 02:53:13 INFO - SUITE-END | took 1174s 02:53:13 INFO - Completed test suite (00:19:35) 02:53:13 INFO - javascript benchmark 02:53:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7081.2320519190025, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3078.492048811946, 3093.3658599987007, 3130.593022907022, 3137.215696075981, 3144.355407141536, 5336.439673834245, 5354.571634269254, 5424.457554244574, 5444.945550544493, 5451.073317536018, 5279.868003299919, 5343.1718083697, 5347.759350829212, 5439.836804895849, 5459.727013649322, 4797.6161907047435, 4821.132196204681, 4861.708297502143, 4973.353464049686, 5007.774650140753, 4821.30091136785, 5069.391672999245, 5084.79660813567, 5085.618578606601, 5094.414142373619, 4842.394700662418, 4894.241392584155, 4919.606431485473, 4970.975145124287, 4999.075171093341, 4928.162212423897, 4940.1601727706375, 4941.579965702919, 4943.184374578226, 4998.750062496861, 4926.753662316905, 4927.802887884481, 4944.085344211332, 4949.158643030693, 4969.13040217964, 5228.79084836606, 5397.352317721859, 5411.107167317388, 5458.399576046631, 5490.3411590609385, 5799.21710569072, 5817.796377126822, 5828.883422331572, 5832.270966129234, 5859.8535036624, 5610.775568977236, 5911.763529458816, 5917.289925208959, 5918.437748413894, 5923.496502797268, 5388.164834450667, 5417.214503896913, 5418.4039755626845, 5419.810306639288, 5426.213199086111, 5882.705864706748, 5891.381404952418, 5891.911621325684, 5901.203337549462, 5906.409359064145, 5613.887722245532, 5652.208690783294, 5655.773769049192, 5659.490645841812, 5735.827925162252, 5859.0, 5884.9705751470965, 5898.4101589840675, 5918.23063001807, 5937.910931336033, 5541.944580554224, 5733.426657334233, 5842.298924129047, 5884.382139875337, 5912.852178695567, 5546.251256080377, 5741.110127930177, 5793.188953546507, 5800.506956908625, 5802.82591522255, 4388.670849686287, 4404.6035856772405, 4425.491068527161, 4427.402300689366, 4457.442819647544, 3934.881953541398, 3956.7625942443547, 3962.6829853611644, 3968.980155099206, 3982.8008599570485, 5457.890842183214, 5497.202905578669, 5524.861878452991, 5564.527015203753, 5600.775968961278, 5925.081612350093, 5942.37605051472, 5946.970265148647, 5958.195643588147, 5985.191999080155, 5641.294838145232, 5650.7739690412745, 5667.489925906688, 5668.489835914787, 5673.971630141823, 4902.362692849907, 4992.251162325608, 5003.224500202475, 5035.345405097314, 5086.745662716849, 6022.3676513966275, 6026.427489388501, 6028.969855150696, 6037.486813620803, 6042.214512113485, 5800.796972105956, 5807.883842323215, 5810.883782324415, 5829.3296270927685, 5831.970840145772, 5869.970650146722, 5969.761209551743, 5990.4908082813445, 6034.125051867367, 6072.514198863992, 5736.340320863154, 5747.5689323300085, 5749.568782341257, 5759.308882934075, 5770.538356931352, 5705.885882282414, 5864.618799778172, 5874.441928016831, 5879.588428809942, 5882.23530940975, 5537.584681149011, 5734.111212762028, 5756.913646295393, 5780.104083867007, 5781.479666830005, 5556.555475562026, 5576.944230557642, 5663.263775709132, 5674.4892959633835, 5692.402297758676, 5587.832365029056, 5595.776168953359, 5598.468145526169, 5603.887922241451, 5604.495595396434, 5535.086710692691, 5741.397153299011, 5754.6547207167705, 5818.563607729522, 5823.854403639943, 5672.262605861211, 5681.460261275172, 5682.431756824284, 5684.8010319638615, 5700.2304688868135], "value": 5364.146101805463, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.9443352881477, 606.833120891755, 615.8460384903774, 640.7981485831963, 644.7324360390438, 38847.0, 43883.341749873776, 43906.780466097625, 43938.34092488611, 44012.33981490272, 43985.78007109968, 44077.55922440783, 44289.0, 44478.77760611192, 44507.55492445075, 8661.220490155869, 8796.73609791704, 8833.867491987625, 8836.955815220947, 8908.465492070463, 8641.222289993932, 8764.123587641217, 8769.0, 8772.868406973901, 8783.912160878404, 8775.341849361323, 8829.470231786081, 8833.2491738202, 8847.646094156225, 8847.690330838423, 8745.693900713477, 8837.602307896128, 8839.07189745077, 8848.778780530474, 8852.203301702813, 8740.082291359442, 8793.956030219872, 8807.471551706918, 8820.33847461443, 8832.11678832118, 34401.311973760385, 35392.46911296333, 35689.0, 35720.82139589285, 35845.46231806525, 3388.542546756181, 3438.381091403546, 3573.908385740078, 3619.963800361989, 3717.6096509866343, 31182.0, 31709.20726981844, 31917.8404107978, 32073.358532829214, 32695.6730432695, 4066.674666026711, 4087.182563487285, 4139.317012692902, 4178.770167640779, 4260.786960651955, 302789.0, 303938.0, 306296.0, 306875.0, 307155.0, 33986.32027359439, 34482.65517344794, 34578.654213458045, 34609.30781384408, 34983.65016349855, 36373.27253454916, 36381.45427818585, 36444.45333319949, 36461.817690911375, 36478.63521364806, 15557.29992150356, 15829.841701582836, 15867.682646347008, 15890.284937177854, 15908.204589770465, 13204.933975330254, 13345.0, 13396.129251598615, 13426.731465370638, 13431.462741490232, 8236.876446853303, 8257.628406721711, 8274.627641756135, 8347.0, 8360.205780450848, 3143.449896268144, 3166.398384306974, 3187.298794265258, 3190.808551486918, 3203.3913556424204, 978.6868202175235, 1004.2417974429259, 1014.832552628808, 1047.5757318286107, 1090.5801266512292, 32690.509642355384, 33180.0, 33290.66709332875, 33405.66594334074, 33876.830615847255, 1093.9234253602172, 1119.4514687802919, 1136.0570726297153, 1137.5734099712608, 1178.4991378664206, 15912.602184945468, 16565.337386504645, 16825.579360516083, 16920.830791692173, 17174.828251717572, 608832.0, 620252.0, 621660.0, 626554.0, 632321.0, 58455.0, 58850.411495884495, 59156.704216479506, 59252.70373648104, 59453.0, 1334.7797613393682, 1350.824392828926, 1382.861713828609, 1383.764759990804, 1401.2083173007218, 29936.25159370946, 31098.689013110485, 31183.064508064796, 31303.530447042856, 31434.371312573163, 51516.227256590435, 52056.47943520516, 52145.0, 52273.0, 52382.73808630933, 511899.0, 521363.0, 524943.0, 526349.0, 526702.0, 27928.720712792612, 28531.0, 28559.42881142407, 28676.569851452663, 28847.278818029718, 47929.520704793904, 48358.27462588134, 48487.27269091037, 48751.486325802216, 48867.51132488772, 41545.376819347126, 41825.0, 42049.0, 42503.787481063635, 42853.0, 41032.0, 41052.589474104876, 42526.0, 42647.14705705931, 44669.77665111654, 41705.79147104245, 41816.58183418127, 42301.36547951845, 42666.0, 42814.0, 36255.45616815802, 38563.0, 38710.0, 38743.41884871673, 39098.804505977285, 28171.43657126805, 28473.43053138967, 28687.282817929718, 28689.56965645475, 29051.0], "value": 18766.53385754247, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.7595139110969, 377.87341240684367, 379.7968087073414, 387.55431254057845, 393.5965635223895, 17519.737203941935, 19114.42656720299, 19744.111514981825, 19856.503587410323, 19858.106385212664, 17483.0, 18419.26322947084, 18443.262269509203, 19319.323823666175, 19332.806671933275, 4942.678725882824, 4982.676126051813, 5095.796168153288, 5142.408623008346, 5154.123798954187, 4961.107000739866, 4971.651984361096, 5007.799688012475, 5057.797688092472, 5079.822206222783, 5047.873803154932, 5059.468755780646, 5069.974650126763, 5071.670341427795, 5082.491750824925, 4855.635827312948, 4986.526280003394, 5029.597632189452, 5035.823746168867, 5096.821611243608, 4764.523547645243, 4862.0, 4864.246041863516, 4877.6829506081995, 4888.608911287089, 12123.272603643722, 12597.622071337782, 12681.048921330937, 12686.682832929251, 12727.554535591302, 2306.7808558186944, 2393.628987506939, 2502.361897716089, 2780.152053623644, 2810.901618443345, 9223.44659320443, 9390.15488606022, 9418.811623767555, 9423.575939082757, 9546.856797148048, 1834.385480863912, 1852.8054554271741, 1901.809819018101, 1910.3122875764714, 1956.6184594004176, 77306.0, 78560.60719696422, 79617.60191199064, 80912.99999999942, 81896.18103818945, 8866.33502487316, 9267.814643707088, 9478.099580539838, 10152.086312231786, 10570.101541368917, 14567.271636418349, 14652.413903443956, 14712.779308310384, 14723.484678036217, 14725.779113313309, 8026.678932842621, 8051.51690898548, 8052.872597836307, 8085.716999904975, 8154.2253485918745, 8029.7189598363775, 8052.114267430578, 8082.757517274374, 8125.309348705308, 8176.264136227768, 4309.116631090682, 4321.0, 4451.9554804451545, 4488.102379524108, 4533.38799262102, 1830.5240637434097, 1888.4051523769967, 1928.3443629166152, 1939.2153544443693, 1975.0, 943.8018016216535, 972.1299437003984, 1017.3641474078701, 1019.2915923433143, 1033.256055639938, 18393.264269429073, 19191.424257272305, 19242.326518571783, 19538.511537211398, 19577.608447830964, 970.1365784451843, 987.5950860147449, 1023.1098943918689, 1061.75048863517, 1100.378286268272, 10112.949435252776, 10789.421553090271, 10789.97307474485, 10799.78400431987, 10843.728906777395, 520661.0, 525770.0, 534340.0, 534562.0, 547380.0, 94492.52753736188, 98009.0, 98158.5092074535, 98863.50568247112, 99115.50442247743, 999.3703966501058, 1034.4569101221919, 1055.1084333737979, 1056.984145237822, 1069.7806949575318, 17529.737053944456, 17618.29526818913, 17716.291348345923, 18013.819861801214, 18220.36228731988, 41251.58748412477, 41906.790466047474, 42722.0, 43502.782486087366, 43844.78077609592, 59969.0, 60447.39552604418, 60661.696691518024, 61942.69028654828, 62236.0, 7989.440739148204, 8106.432549721463, 8206.548639824867, 8225.588720563828, 8517.616707248064, 11953.641390758292, 12014.63956081319, 12101.515939362327, 13400.396982135633, 13493.662658433224, 10654.8401773975, 11203.15976301797, 11757.0, 11876.346800926032, 11998.220115692453, 11643.941780291045, 11787.882121178678, 11807.173497855068, 11989.580364687194, 12100.334481603597, 11913.702157446132, 11945.522179113086, 12086.274823510266, 12312.13815032939, 12332.691682707646, 6858.0, 7207.207207207308, 7919.485233459806, 8121.959390203011, 8305.12796156419, 10507.264491485828, 11249.831252531383, 11350.659480215276, 11408.94295528517, 11497.770044599229], "value": 8842.406064398, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1448.5726710620365, 1454.2510607037377, 1532.5938626264042, 1663.7504374343846, 1664.3009935826951, 7154.499185057048, 7797.376209903208, 8334.249917507423, 8512.319014478835, 8533.061363250037, 8448.831023379544, 8474.576271186446, 8478.491290522574, 8547.10255423181, 8556.0, 2232.241038047068, 2250.1449449209276, 2260.9208677696283, 2266.9319920402413, 2267.5238199977944, 2200.4058904095887, 2225.1544413122992, 2294.0479700924097, 2295.2655150351893, 2299.839011269212, 2219.056900817154, 2234.181586885121, 2261.1746712450004, 2267.2291420916886, 2293.1859189987563, 2164.8701077935298, 2176.0, 2184.2682701295007, 2191.3097374327035, 2195.2755590655047, 2158.2769772126358, 2165.523584811355, 2165.72928383952, 2167.729033870766, 2168.3711723600136, 8410.36922230829, 8432.325413966868, 8506.31949444043, 8509.829803403898, 8522.914770852274, 4734.786934587917, 4815.916418805776, 4816.08494386069, 4824.372831531879, 4842.370491836074, 3112.6264848218134, 3120.1419609607315, 3121.4693502104697, 3137.2470607054142, 3141.4502462069277, 1040.6825918094978, 1052.5631862776938, 1070.0, 1079.4440862955585, 1081.7566047639218, 11076.39079850608, 11117.888821111766, 11151.888481115166, 11193.832092518618, 11201.159913006557, 4187.14163596462, 4282.914341713211, 4338.154059958278, 4355.1725172217175, 4357.302831546937, 9452.338336316392, 9458.810823783624, 9525.476098814632, 9567.425954442755, 9603.807923841485, 4794.2808578712775, 4814.133455977888, 4820.734859582757, 4826.420829500412, 4828.155072862235, 4060.5127384713433, 4477.619402350837, 4487.483939346952, 4623.69945953512, 4653.906921861544, 3860.613938606173, 3863.74885632433, 4001.139754952699, 4006.1186538961383, 4010.9197816043516, 1191.7676053169723, 1212.4483360071147, 1217.5738491527895, 1218.4334284557547, 1222.1689251309017, 803.9115697273295, 949.7293271417751, 959.64972784933, 963.7686955130858, 968.4286271100085, 5423.430539793344, 5725.198472213893, 5751.309842818889, 5818.7672493100645, 5944.7324870380935, 952.2715122930963, 973.4159504297365, 983.1299300119302, 1001.3140998416109, 1010.545254635417, 3722.553293604785, 3840.0, 3882.068303607114, 3896.2207558488417, 3963.365861462152, 9697.466639334763, 9715.319927605, 9823.656172034087, 9923.900760992297, 9938.0, 9709.126178643955, 9714.854277185848, 9774.51127443625, 10227.590896364061, 10269.537870795832, 7962.0, 8046.718364857202, 8100.959495202605, 8154.429189956765, 8164.306033987059, 5725.656460612377, 5784.82645520635, 5838.970805145947, 6123.693815309306, 6203.0, 8997.505137217255, 9148.170365926708, 9376.156145946898, 9719.951400242953, 9730.27022973294, 9801.705948821547, 9858.457784821616, 9864.654737084167, 10119.139873110573, 10348.172146228435, 7109.928900710926, 7580.0, 7859.724909628136, 8170.305524030524, 8361.498310101413, 8058.83882322362, 8072.677092916218, 8081.393895457747, 8169.918300816916, 8178.959105204436, 6834.965825170842, 7060.576365417885, 7170.820729481596, 7182.60495672743, 7308.415326773739, 7011.1586609607175, 7125.3230943060325, 7202.783916482514, 7214.819629509304, 7268.27317268269, 7070.116235470567, 7149.82125446868, 7181.856362872818, 7184.030155929092, 7191.4246860250005, 4889.975550122226, 5001.749912504288, 5055.747212639427, 5072.4673909239, 5182.32629758129, 4962.082014827269, 5080.466551012239, 5113.974430127825, 5149.897002060013, 5169.870753231049], "value": 4435.9572856686345, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [269.15351220411793, 281.81541090585665, 283.7999210556557, 284.3914023988663, 287.99280017999547, 5411.512963833255, 5516.779328826842, 5614.410486898873, 5668.121441176624, 5670.8015219467325, 5518.530924871381, 5527.889442211153, 5568.721563921808, 5580.274564306645, 5580.609357344987, 4195.594475850594, 4197.391378250152, 4214.4099826024385, 4216.894577635553, 4223.577642235768, 4018.537868145157, 4194.3498757692605, 4216.093539888923, 4231.978840105795, 4255.702100852942, 4136.834526618932, 4159.688023398242, 4168.228877657628, 4170.103427763031, 4188.492142828579, 4191.266528357556, 4192.643625291854, 4215.199112168693, 4221.620054195107, 4228.577142285778, 3648.0, 3660.359437098497, 3673.834677439522, 3678.411454167347, 3693.0, 5176.430592634807, 5332.546733527654, 5424.0, 5429.918551221735, 5431.185322201702, 4707.199776038082, 4735.857924262277, 4741.834035808764, 4751.263554149113, 4784.44032442645, 5511.889762204773, 5779.913301300484, 5796.652200867961, 5801.7389217485315, 5819.330776960619, 3889.2610404023426, 3895.7272990890647, 3909.354956432185, 3923.117298607819, 3928.64642182205, 6075.817725468199, 6078.331383547807, 6082.270127584674, 6100.206973093514, 6125.142480052797, 3884.7086468514976, 3990.2618015667194, 4002.8398864045694, 4028.013136781449, 4029.294873397144, 3940.113474468279, 3971.3050216212046, 3980.4626375439525, 3985.92028159441, 4003.959960400417, 4693.413323334583, 4693.624510039189, 4701.388819453449, 4725.243960966298, 4730.0, 5607.467290607386, 5837.3287071986415, 5910.172575839386, 5925.318588362394, 5970.58205925581, 1363.8158848555518, 1364.7543442180304, 1384.349355802771, 1389.2567476400077, 1391.958241252764, 831.5925196653717, 848.240824462103, 854.2013217641525, 866.5537248317122, 868.769776009358, 4973.875653108701, 5026.447090820006, 5048.848534543969, 5055.974720126449, 5082.720450375191, 5334.453008627532, 5348.973255133699, 5374.704391258519, 5376.327959005124, 5376.489233522809, 4650.37219975299, 5048.671836330626, 5070.61970352225, 5110.361204849394, 5116.283720279164, 2853.315204350982, 2889.971100289012, 2912.796104272723, 2923.5760814681753, 2933.6919623439658, 5456.03582710224, 5544.3346798383645, 5544.805931792368, 5548.167774833726, 5554.555815488002, 5150.982991483539, 5369.624126311199, 5455.563554915597, 5458.536024437888, 5540.36285827135, 5424.538914192338, 5517.889642207133, 5533.557315414757, 5555.250041244381, 5555.861048485051, 5052.9285824280905, 5301.0, 5351.491608297206, 5371.301730774974, 5427.457254274541, 5082.390113186441, 5243.318368612056, 5248.475152484873, 5259.316288882421, 5351.5451186648015, 5451.291332126957, 5541.4483944495605, 5542.307211598551, 5563.193336966036, 5599.412061733459, 3613.747037707335, 3651.9269614608093, 3666.7066634668627, 3674.273091646922, 3693.4118329118737, 5645.774169033357, 5805.216295800013, 5935.673537955454, 6048.758049677964, 6055.666938318434, 5909.23179986599, 5925.229720136354, 5944.970275148597, 5947.851303717269, 5964.091490723101, 5861.0, 5891.0, 5891.558133139946, 5913.970430147821, 5916.674582897982, 5623.803166889139, 5822.94177058224, 5825.621334613236, 5837.270341207349, 5841.561882858888, 5907.143464197753, 5965.135055416853, 5967.49276311501, 5988.461038506555, 5992.370801065826, 5683.943160568507, 5782.537397008314, 5786.971065144648, 5804.709764511842, 5806.200077975841], "value": 4196.2993070783305, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [740.4816628360143, 772.1544908325382, 795.8169620987172, 795.9124496305407, 820.2125959079284, 15144.318505667245, 16121.193940302997, 16169.27238274279, 16224.756628650564, 16623.08573028483, 15552.688946221097, 16233.756493652605, 16239.025658460501, 16323.34706611737, 16365.59086022847, 655.4919937048778, 791.9841603167947, 795.9641816118288, 797.6291024673526, 798.0184373220942, 771.2750014985924, 794.6821271491392, 797.8962734844462, 799.4883274704165, 800.5356893002045, 822.5023860564362, 827.8551253530608, 828.5235989306143, 831.2061980808344, 833.3291700181352, 824.5918270456102, 825.6037102190921, 827.4084029918607, 828.7223780033665, 831.0484495252902, 596.2993482657903, 596.749365266589, 600.1897438458091, 602.8402473344568, 603.9154518367432, 15348.309326080353, 15427.30577124032, 15516.379344826193, 15526.068435893769, 15569.37722491099, 14915.254237288093, 14943.775843362359, 14971.176585287805, 15030.924845375812, 15076.698466030617, 12366.083257095164, 12400.13199076065, 12504.187227830253, 12667.30329831859, 12747.42636581356, 3647.2340808430263, 3655.762375445614, 3715.3869611514338, 3747.156889699823, 3843.327417701891, 77523.0, 78000.60999694966, 78673.60663196647, 79676.0, 79901.0, 11176.944115279372, 11309.886901131047, 11616.825747613793, 11621.07031437483, 11842.88157118435, 20908.89545552293, 21403.67894481584, 21536.0, 21576.0, 21589.13643454244, 8830.0, 8880.733577992542, 9055.637774489078, 9070.773230669154, 9167.220786233245, 4734.597559207506, 4740.834070807574, 4811.807527698853, 5002.224655178453, 5058.822941197041, 3743.1016556026902, 3830.0233440472502, 3849.287881741887, 3856.73002889795, 3858.6527212551005, 638.1385130074362, 641.9518536109717, 643.6266965160289, 644.22049320322, 661.7022339947043, 617.200725061047, 620.4354037825557, 637.7066549387333, 741.0736579275905, 757.8522188173364, 10058.47368684095, 10370.896291037145, 10662.41356725372, 10888.836667449994, 11238.0, 606.1937622961451, 645.6642545876118, 685.4961603221628, 734.1153909538992, 763.8579283697385, 4830.758462076882, 5007.524285192901, 5083.313752643346, 5251.422343542207, 5294.814681486129, 105130.47434762931, 107007.0, 107270.0, 109211.45394272977, 110112.4494377539, 99309.50345248227, 103020.0, 103156.0, 103649.0, 104381.47809261057, 84078.5796071028, 87857.56071219732, 89092.9999999987, 89893.0, 91568.0, 9177.36376804366, 9195.402298850553, 9195.77010574741, 9301.72094837156, 9469.0, 49499.50500494949, 49715.25427118524, 51180.74409628077, 51278.230826538376, 52497.0, 67789.3221067783, 72632.0, 73152.26847731454, 73760.0, 74303.68418684472, 12607.306598137191, 12742.980561554868, 12777.169483983884, 12855.742885142057, 13356.866431335951, 13972.37124329428, 13990.300484975507, 14033.508827190999, 14101.0, 14313.069650472686, 12852.614421567368, 12988.545400910923, 13259.0, 13296.933515332748, 13833.86166138366, 12268.386580670753, 12422.0, 13173.40719667598, 13262.867371326549, 13374.665633359244, 11514.0, 13363.933180334036, 13368.933155334162, 13573.11774734639, 13816.309184540934, 11488.655340339803, 11503.942480287546, 11522.481488333213, 11539.88460115388, 11783.410829458322, 11021.393823339793, 11199.552017919192, 11393.695828209726, 11957.222780519238, 12116.75766484683], "value": 7608.522391387197, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1539.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 105.0, 113.0, 112.0, 111.0, 112.0, 110.0, 112.0, 114.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 130.0, 151.0, 179.0, 136.0, 173.0, 156.0, 129.0, 183.0, 127.0], "value": 151.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 163.0, 163.0, 168.0, 173.0, 163.0, 162.0, 161.0, 168.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 168.0, 75.0, 75.0, 75.0, 75.0, 162.0, 77.0], "value": 93.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 149.0, 85.0, 86.0, 85.0, 142.0, 85.0, 86.0, 145.0], "value": 103.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 118.0, 119.0, 119.0, 117.0, 118.0, 117.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 151.0, 147.0, 148.0, 148.0, 147.0, 147.0, 148.0, 147.0, 148.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 96.0, 95.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 55.0, 55.0, 55.0, 55.0, 55.0, 58.0, 56.0, 55.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 63.0, 61.0, 70.0, 61.0, 61.0, 61.0, 62.0, 62.0], "value": 62.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 84.0, 80.0, 84.0, 79.0, 86.0, 81.0, 81.0, 103.0, 81.0], "value": 83.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 123.0, 122.0, 122.0, 123.0, 132.0, 128.0, 135.0, 131.0, 129.0], "value": 127.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 157.0, 165.0, 162.0, 162.0, 164.0, 163.0, 163.0, 162.0, 159.0], "value": 162.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 62.0, 63.0, 66.0, 62.0, 67.0, 62.0, 61.0, 66.0], "value": 63.5, "unit": "score"}]}]} 02:53:13 INFO - Return code: 0 02:53:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:53:13 ERROR - # TBPL SUCCESS # 02:53:13 INFO - Running post-action listener: _resource_record_post_action 02:53:13 INFO - ##### 02:53:13 INFO - ##### Finished run-tests step (success) 02:53:13 INFO - ##### 02:53:13 INFO - Running post-run listener: _resource_record_post_run 02:53:13 INFO - Total resource usage - Wall time: 1194s; CPU: 14.0%; Read bytes: 10260480; Write bytes: 434225152; Read time: 3116; Write time: 407144 02:53:13 INFO - TinderboxPrint: CPU usage
13.5% 02:53:13 INFO - TinderboxPrint: I/O read bytes / time
10,260,480 / 3,116 02:53:13 INFO - TinderboxPrint: I/O write bytes / time
434,225,152 / 407,144 02:53:13 INFO - TinderboxPrint: CPU idle
8,233.3 (86.4%) 02:53:13 INFO - TinderboxPrint: CPU user
1,230.3 (12.9%) 02:53:13 INFO - TinderboxPrint: Swap in / out
0 / 0 02:53:13 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 54317056; Read time: 156; Write time: 44360 02:53:13 INFO - run-tests - Wall time: 1177s; CPU: 14.0%; Read bytes: 8495104; Write bytes: 379908096; Read time: 2908; Write time: 362784 02:53:14 INFO - Running post-run listener: _upload_blobber_files 02:53:14 INFO - Blob upload gear active. 02:53:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:53:14 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 02:53:14 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'] 02:53:14 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 02:53:14 INFO - (blobuploader) - INFO - Open directory for files ... 02:53:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:53:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:53:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:53:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:53:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:53:17 INFO - (blobuploader) - INFO - Done attempting. 02:53:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:53:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:53:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:53:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:53:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:53:18 INFO - (blobuploader) - INFO - Done attempting. 02:53:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:53:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:53:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:53:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:53:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:53:19 INFO - (blobuploader) - INFO - Done attempting. 02:53:19 INFO - (blobuploader) - INFO - Iteration through files over. 02:53:19 INFO - Return code: 0 02:53:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:53:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:53:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/da30163887cf0681a4fd9f4e0f60a01c3b294fb9cc40d69de84d227a3919e71d322a3fdb0ec896deeedd6da006a99f17573a19b50ad5cc30d6c756f77dfaba01", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dfe2a41fcc110f7ecdc722d4ac13f147c8f748dd19b033c1f6eb8c263ae05b42d6fcc65c36062770a8fc8c020228c87337127f768cef7a0d942e3723105598f4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/624a36d084d6c64ea71238d479e54c1e8274bc761e92e9a936d4fa4f951b5a63e7a344500a273be443cc2f1eb439dfbce1579746d0ea1780bb39d5bac7f8138f"} 02:53:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:53:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:53:19 INFO - Contents: 02:53:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/da30163887cf0681a4fd9f4e0f60a01c3b294fb9cc40d69de84d227a3919e71d322a3fdb0ec896deeedd6da006a99f17573a19b50ad5cc30d6c756f77dfaba01", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dfe2a41fcc110f7ecdc722d4ac13f147c8f748dd19b033c1f6eb8c263ae05b42d6fcc65c36062770a8fc8c020228c87337127f768cef7a0d942e3723105598f4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/624a36d084d6c64ea71238d479e54c1e8274bc761e92e9a936d4fa4f951b5a63e7a344500a273be443cc2f1eb439dfbce1579746d0ea1780bb39d5bac7f8138f"} 02:53:19 INFO - Running post-run listener: copy_logs_to_upload_dir 02:53:19 INFO - Copying logs to upload dir... 02:53:19 INFO - mkdir: /builds/slave/test/build/upload/logs 02:53:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.863277 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-06-23 02:53:19.479214) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 02:53:19.483020) ========= 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=232498196343f89f466a4a9a000001c8-1466674352.122626-1345932662 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/da30163887cf0681a4fd9f4e0f60a01c3b294fb9cc40d69de84d227a3919e71d322a3fdb0ec896deeedd6da006a99f17573a19b50ad5cc30d6c756f77dfaba01", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dfe2a41fcc110f7ecdc722d4ac13f147c8f748dd19b033c1f6eb8c263ae05b42d6fcc65c36062770a8fc8c020228c87337127f768cef7a0d942e3723105598f4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/624a36d084d6c64ea71238d479e54c1e8274bc761e92e9a936d4fa4f951b5a63e7a344500a273be443cc2f1eb439dfbce1579746d0ea1780bb39d5bac7f8138f"} build_url:https://queue.taskcluster.net/v1/task/M0c7I6k6SPGMfnUxsOzNCg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011419 build_url: 'https://queue.taskcluster.net/v1/task/M0c7I6k6SPGMfnUxsOzNCg/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/da30163887cf0681a4fd9f4e0f60a01c3b294fb9cc40d69de84d227a3919e71d322a3fdb0ec896deeedd6da006a99f17573a19b50ad5cc30d6c756f77dfaba01", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dfe2a41fcc110f7ecdc722d4ac13f147c8f748dd19b033c1f6eb8c263ae05b42d6fcc65c36062770a8fc8c020228c87337127f768cef7a0d942e3723105598f4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/624a36d084d6c64ea71238d479e54c1e8274bc761e92e9a936d4fa4f951b5a63e7a344500a273be443cc2f1eb439dfbce1579746d0ea1780bb39d5bac7f8138f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 02:53:19.509126) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 02:53:19.509491) ========= 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=232498196343f89f466a4a9a000001c8-1466674352.122626-1345932662 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004373 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 02:53:19.591662) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 02:53:19.592006) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 02:53:19.592348) ========= ========= Total master_lag: 0.17 =========