builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-059 starttime: 1466674474.37 results: success (0) buildid: 20160622234707 builduid: c6ff59ffb4aa40afbb526fc4b08ddfeb revision: 437fc937572dd344f58226d40ba9eccb4ffcaedb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 02:34:34.369563) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-23 02:34:34.370093) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 02:34:34.370432) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-23 02:34:34.388808) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 02:34:34.389218) ========= 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=3a3620fb28aea1604ab609ef000001d2-1466674477.101294-1412096403 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-23 02:34:37-- 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% 206M=0s 2016-06-23 02:34:38 (206 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.127264 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 02:34:34.530558) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 02:34:34.530897) ========= 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=3a3620fb28aea1604ab609ef000001d2-1466674477.101294-1412096403 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015024 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 02:34:34.580193) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 02:34:34.580563) ========= 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=3a3620fb28aea1604ab609ef000001d2-1466674477.101294-1412096403 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-23 02:34:38,144 truncating revision to first 12 chars 2016-06-23 02:34:38,144 Setting DEBUG logging. 2016-06-23 02:34:38,144 attempt 1/10 2016-06-23 02:34:38,144 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:34:38,478 unpacking tar archive at: fx-team-437fc937572d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.668551 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 02:34:35.265720) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 02:34:35.266091) ========= script_repo_revision: 437fc937572dd344f58226d40ba9eccb4ffcaedb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-23 02:34:35.266583) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 02:34:35.266891) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-23 02:34:35.277442) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-06-23 02:34:35.277872) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3a3620fb28aea1604ab609ef000001d2-1466674477.101294-1412096403 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:34:38 INFO - MultiFileLogger online at 20160623 02:34:38 in /builds/slave/test 02:34:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 02:34:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:34:38 INFO - {'append_to_log': False, 02:34:38 INFO - 'base_work_dir': '/builds/slave/test', 02:34:38 INFO - 'blob_upload_branch': 'Fx-Team', 02:34:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:34:38 INFO - 'branch': 'Fx-Team', 02:34:38 INFO - 'buildbot_json_path': 'buildprops.json', 02:34:38 INFO - 'config_files': ('talos/linux_config.py',), 02:34:38 INFO - 'default_actions': ('clobber', 02:34:38 INFO - 'read-buildbot-config', 02:34:38 INFO - 'download-and-extract', 02:34:38 INFO - 'populate-webroot', 02:34:38 INFO - 'create-virtualenv', 02:34:38 INFO - 'install', 02:34:38 INFO - 'run-tests'), 02:34:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:34:38 INFO - 'download_minidump_stackwalk': True, 02:34:38 INFO - 'download_symbols': 'ondemand', 02:34:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:34:38 INFO - 'tooltool.py': '/tools/tooltool.py', 02:34:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:34:38 INFO - '/tools/misc-python/virtualenv.py')}, 02:34:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:34:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:34:38 INFO - 'installer_path': 'installer.exe', 02:34:38 INFO - 'log_level': 'info', 02:34:38 INFO - 'log_name': 'talos', 02:34:38 INFO - 'log_to_console': True, 02:34:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:34:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:34:38 INFO - 'opt_config_files': (), 02:34:38 INFO - 'pip_index': False, 02:34:38 INFO - 'sps_profile': False, 02:34:38 INFO - 'sps_profile_interval': 0, 02:34:38 INFO - 'suite': 'dromaeojs', 02:34:38 INFO - 'system_bits': '32', 02:34:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:34:38 INFO - 'title': 'talos-linux64-ix-059', 02:34:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:34:38 INFO - 'use_talos_json': True, 02:34:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:34:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:34:38 INFO - 'work_dir': 'build'} 02:34:38 INFO - ##### 02:34:38 INFO - ##### Running clobber step. 02:34:38 INFO - ##### 02:34:38 INFO - Running pre-action listener: _resource_record_pre_action 02:34:38 INFO - Running main action method: clobber 02:34:38 INFO - rmtree: /builds/slave/test/build 02:34:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:34:39 INFO - Running post-action listener: _resource_record_post_action 02:34:39 INFO - ##### 02:34:39 INFO - ##### Finished clobber step (success) 02:34:39 INFO - ##### 02:34:39 INFO - ##### 02:34:39 INFO - ##### Running read-buildbot-config step. 02:34:39 INFO - ##### 02:34:39 INFO - Running pre-action listener: _resource_record_pre_action 02:34:39 INFO - Running main action method: read_buildbot_config 02:34:39 INFO - Using buildbot properties: 02:34:39 INFO - { 02:34:39 INFO - "project": "", 02:34:39 INFO - "product": "firefox", 02:34:39 INFO - "script_repo_revision": "production", 02:34:39 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:34:39 INFO - "repository": "", 02:34:39 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 02:34:39 INFO - "buildid": "20160622234707", 02:34:39 INFO - "pgo_build": "True", 02:34:39 INFO - "basedir": "/builds/slave/test", 02:34:39 INFO - "buildnumber": 819, 02:34:39 INFO - "slavename": "talos-linux64-ix-059", 02:34:39 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:34:39 INFO - "platform": "ubuntu64_hw", 02:34:39 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:34:39 INFO - "branch": "fx-team", 02:34:39 INFO - "repo_path": "integration/fx-team", 02:34:39 INFO - "revision": "437fc937572dd344f58226d40ba9eccb4ffcaedb", 02:34:39 INFO - "stage_platform": "linux64-pgo", 02:34:39 INFO - "builduid": "c6ff59ffb4aa40afbb526fc4b08ddfeb", 02:34:39 INFO - "slavebuilddir": "test" 02:34:39 INFO - } 02:34:39 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:34:39 INFO - Running post-action listener: _resource_record_post_action 02:34:39 INFO - ##### 02:34:39 INFO - ##### Finished read-buildbot-config step (success) 02:34:39 INFO - ##### 02:34:39 INFO - ##### 02:34:39 INFO - ##### Running download-and-extract step. 02:34:39 INFO - ##### 02:34:39 INFO - Running pre-action listener: _resource_record_pre_action 02:34:39 INFO - Running main action method: download_and_extract 02:34:39 INFO - mkdir: /builds/slave/test/build/tests 02:34:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:34:39 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:34:39 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:34:39 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:34:39 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:34:39 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:34:40 INFO - Downloaded 1361 bytes. 02:34:40 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:34:40 INFO - Using the following test package requirements: 02:34:40 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:34:40 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:34:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:34:40 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:34:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:34:40 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:34:40 INFO - u'jsshell-linux-x86_64.zip'], 02:34:40 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:34:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:34:40 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:34:40 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:34:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:34:40 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:34:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:34:40 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:34:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:34:40 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:34:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:34:40 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:34: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:34: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:34: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:34: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:34: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:34: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:34:41 INFO - Downloaded 24269439 bytes. 02:34: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:34: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:34:43 INFO - Return code: 0 02:34:43 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:34: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:34:43 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:34: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.common.tests.zip 02:34: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.common.tests.zip 02:34: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.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:34: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.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:34:44 INFO - Downloaded 24269439 bytes. 02:34:44 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:34:44 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:34:45 INFO - Return code: 0 02:34:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:34:45 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:34:45 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:34:45 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:34:45 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:34:45 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:34:47 INFO - Downloaded 14405384 bytes. 02:34:47 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:34:47 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:34:47 INFO - Return code: 0 02:34:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:34:47 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:34:47 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:34:47 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:34:47 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:34:47 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:34:49 INFO - Downloaded 60154354 bytes. 02:34:49 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:34:49 INFO - mkdir: /builds/slave/test/properties 02:34:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:34:49 INFO - Writing to file /builds/slave/test/properties/build_url 02:34:49 INFO - Contents: 02:34:49 INFO - build_url:https://queue.taskcluster.net/v1/task/M0c7I6k6SPGMfnUxsOzNCg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:34:49 INFO - Running post-action listener: _resource_record_post_action 02:34:49 INFO - Running post-action listener: set_extra_try_arguments 02:34:49 INFO - ##### 02:34:49 INFO - ##### Finished download-and-extract step (success) 02:34:49 INFO - ##### 02:34:49 INFO - ##### 02:34:49 INFO - ##### Running populate-webroot step. 02:34:49 INFO - ##### 02:34:49 INFO - Running pre-action listener: _resource_record_pre_action 02:34:49 INFO - Running main action method: populate_webroot 02:34:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:34:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:34:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:34:49 INFO - '--tppagecycles', 02:34:49 INFO - '7'], 02:34:49 INFO - 'tests': ['tsvgm']}}, 02:34:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:34:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:34:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:34:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:34:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:34:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:34:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:34:49 INFO - 'talos_options': ['--disable-e10s'], 02:34:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:34:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:34:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:34:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:34:49 INFO - 'talos_options': ['--disable-e10s'], 02:34:49 INFO - 'tests': ['damp', 'tps']}, 02:34:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:34:49 INFO - 'tests': ['damp', 'tps']}, 02:34:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:34:49 INFO - 'tests': ['dromaeo_dom']}, 02:34:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:34:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:34:49 INFO - 'tests': ['basic_compositor_video']}, 02:34:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:34:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:34:49 INFO - 'tests': ['a11yr', 02:34:49 INFO - 'ts_paint', 02:34:49 INFO - 'tpaint', 02:34:49 INFO - 'sessionrestore', 02:34:49 INFO - 'sessionrestore_no_auto_restore', 02:34:49 INFO - 'tabpaint']}, 02:34:49 INFO - 'other-e10s': {'tests': ['a11yr', 02:34:49 INFO - 'ts_paint', 02:34:49 INFO - 'tpaint', 02:34:49 INFO - 'sessionrestore', 02:34:49 INFO - 'sessionrestore_no_auto_restore', 02:34:49 INFO - 'tabpaint']}, 02:34:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:34:49 INFO - 'ts_paint', 02:34:49 INFO - 'tpaint', 02:34:49 INFO - 'sessionrestore', 02:34:49 INFO - 'sessionrestore_no_auto_restore', 02:34:49 INFO - 'tabpaint']}, 02:34:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:34:49 INFO - 'ts_paint', 02:34:49 INFO - 'tpaint', 02:34:49 INFO - 'sessionrestore', 02:34:49 INFO - 'sessionrestore_no_auto_restore', 02:34:49 INFO - 'tabpaint']}, 02:34:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:34:49 INFO - 'tests': ['a11yr', 02:34:49 INFO - 'ts_paint', 02:34:49 INFO - 'tpaint', 02:34:49 INFO - 'sessionrestore', 02:34:49 INFO - 'sessionrestore_no_auto_restore', 02:34:49 INFO - 'tabpaint']}, 02:34:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:34:49 INFO - 'tests': ['a11yr', 02:34:49 INFO - 'ts_paint', 02:34:49 INFO - 'tpaint', 02:34:49 INFO - 'sessionrestore', 02:34:49 INFO - 'sessionrestore_no_auto_restore', 02:34:49 INFO - 'tabpaint']}, 02:34:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:34:49 INFO - 'tests': ['tsvgx', 02:34:49 INFO - 'tsvgr_opacity', 02:34:49 INFO - 'tart', 02:34:49 INFO - 'tscrollx', 02:34:49 INFO - 'cart']}, 02:34:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:34:49 INFO - 'tsvgr_opacity', 02:34:49 INFO - 'tart', 02:34:49 INFO - 'tscrollx', 02:34:49 INFO - 'cart']}, 02:34:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:34:49 INFO - 'talos_options': ['--disable-e10s'], 02:34:49 INFO - 'tests': ['tp5o']}, 02:34:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:34:49 INFO - 'tests': ['tp5o']}, 02:34:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:34:49 INFO - 'talos_options': ['--disable-e10s', 02:34:49 INFO - '--xperf_path', 02:34:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:34:49 INFO - 'tests': ['tp5n']}, 02:34:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:34:49 INFO - 'talos_options': ['--xperf_path', 02:34:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:34:49 INFO - 'tests': ['tp5n']}}, 02:34:49 INFO - 'talos.zip': {'path': '', 02:34:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:34:49 INFO - Running post-action listener: _resource_record_post_action 02:34:49 INFO - ##### 02:34:49 INFO - ##### Finished populate-webroot step (success) 02:34:49 INFO - ##### 02:34:49 INFO - ##### 02:34:49 INFO - ##### Running create-virtualenv step. 02:34:49 INFO - ##### 02:34:49 INFO - Running pre-action listener: _resource_record_pre_action 02:34:49 INFO - Running main action method: create_virtualenv 02:34:49 INFO - Creating virtualenv /builds/slave/test/build/venv 02:34:49 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:34:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:34:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:34:50 INFO - Using real prefix '/usr' 02:34:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:34:50 INFO - Installing distribute.............................................................................................................................................................................................done. 02:34:52 INFO - Installing pip.................done. 02:34:52 INFO - Return code: 0 02:34:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:34: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:34:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34: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:34:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34: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 0x7f8d68dbdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ac350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283b1c0>, '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 0x283c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283c550>, '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': '3a3620fb28aea1604ab609ef000001d2-1466674477.101294-1412096403', '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:34: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:34: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:34:52 INFO - Using env: {'DISPLAY': ':0', 02:34:52 INFO - 'HOME': '/home/cltbld', 02:34:52 INFO - 'LANG': 'en_US.UTF-8', 02:34:52 INFO - 'LANGUAGE': 'en_US:en', 02:34:52 INFO - 'LOGNAME': 'cltbld', 02:34:52 INFO - 'MAIL': '/var/mail/cltbld', 02:34:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:52 INFO - 'MOZ_NO_REMOTE': '1', 02:34:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:34:52 INFO - 'NO_EM_RESTART': '1', 02:34:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:34:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:52 INFO - 'PWD': '/builds/slave/test', 02:34:52 INFO - 'SHELL': '/bin/bash', 02:34:52 INFO - 'SHLVL': '1', 02:34:52 INFO - 'TERM': 'linux', 02:34:52 INFO - 'TMOUT': '86400', 02:34:52 INFO - 'USER': 'cltbld', 02:34:52 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1466674477.101294-1412096403', 02:34:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:52 INFO - '_': '/tools/buildbot/bin/python'} 02:34:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:34:52 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:34:52 INFO - Cleaning up... 02:34:52 INFO - Return code: 0 02:34:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:34: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:34:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34: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:34:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34: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', '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 0x7f8d68dbdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ac350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283b1c0>, '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 0x283c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283c550>, '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': '3a3620fb28aea1604ab609ef000001d2-1466674477.101294-1412096403', '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:34: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', 'psutil>=3.1.1'] in /builds/slave/test/build 02:34: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 psutil>=3.1.1 02:34:52 INFO - Using env: {'DISPLAY': ':0', 02:34:52 INFO - 'HOME': '/home/cltbld', 02:34:52 INFO - 'LANG': 'en_US.UTF-8', 02:34:52 INFO - 'LANGUAGE': 'en_US:en', 02:34:52 INFO - 'LOGNAME': 'cltbld', 02:34:52 INFO - 'MAIL': '/var/mail/cltbld', 02:34:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:52 INFO - 'MOZ_NO_REMOTE': '1', 02:34:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:34:52 INFO - 'NO_EM_RESTART': '1', 02:34:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:34:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:52 INFO - 'PWD': '/builds/slave/test', 02:34:52 INFO - 'SHELL': '/bin/bash', 02:34:52 INFO - 'SHLVL': '1', 02:34:52 INFO - 'TERM': 'linux', 02:34:52 INFO - 'TMOUT': '86400', 02:34:52 INFO - 'USER': 'cltbld', 02:34:52 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1466674477.101294-1412096403', 02:34:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:52 INFO - '_': '/tools/buildbot/bin/python'} 02:34:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:34:52 INFO - Downloading/unpacking psutil>=3.1.1 02:34:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:34:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:34:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:34:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:34:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:34:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:34:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:34:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:34:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:34:54 INFO - Installing collected packages: psutil 02:34:54 INFO - Running setup.py install for psutil 02:34:55 INFO - building 'psutil._psutil_linux' extension 02:34: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:34:55 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:34:55 INFO - building 'psutil._psutil_posix' extension 02:34:55 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:34:55 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:34:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:34:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:34:55 INFO - Successfully installed psutil 02:34:55 INFO - Cleaning up... 02:34:55 INFO - Return code: 0 02:34:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:34:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:34:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:34:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d68dbdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ac350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283b1c0>, '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 0x283c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283c550>, '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': '3a3620fb28aea1604ab609ef000001d2-1466674477.101294-1412096403', '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:34:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:34:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:34:55 INFO - Using env: {'DISPLAY': ':0', 02:34:55 INFO - 'HOME': '/home/cltbld', 02:34:55 INFO - 'LANG': 'en_US.UTF-8', 02:34:55 INFO - 'LANGUAGE': 'en_US:en', 02:34:55 INFO - 'LOGNAME': 'cltbld', 02:34:55 INFO - 'MAIL': '/var/mail/cltbld', 02:34:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:55 INFO - 'MOZ_NO_REMOTE': '1', 02:34:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:34:55 INFO - 'NO_EM_RESTART': '1', 02:34:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:34:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:55 INFO - 'PWD': '/builds/slave/test', 02:34:55 INFO - 'SHELL': '/bin/bash', 02:34:55 INFO - 'SHLVL': '1', 02:34:55 INFO - 'TERM': 'linux', 02:34:55 INFO - 'TMOUT': '86400', 02:34:55 INFO - 'USER': 'cltbld', 02:34:55 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1466674477.101294-1412096403', 02:34:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:55 INFO - '_': '/tools/buildbot/bin/python'} 02:34:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:34:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:34:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:34:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:34:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:34:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:34:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:34:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:34:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:34:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:34:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:34:57 INFO - Installing collected packages: mozsystemmonitor 02:34:57 INFO - Running setup.py install for mozsystemmonitor 02:34:57 INFO - Successfully installed mozsystemmonitor 02:34:57 INFO - Cleaning up... 02:34:57 INFO - Return code: 0 02:34:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:34: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:34:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:34:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34: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:34:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:34:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:34: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', '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 0x7f8d68dbdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ac350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283b1c0>, '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 0x283c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283c550>, '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': '3a3620fb28aea1604ab609ef000001d2-1466674477.101294-1412096403', '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:34: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:34: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 jsonschema==2.5.1 02:34:57 INFO - Using env: {'DISPLAY': ':0', 02:34:57 INFO - 'HOME': '/home/cltbld', 02:34:57 INFO - 'LANG': 'en_US.UTF-8', 02:34:57 INFO - 'LANGUAGE': 'en_US:en', 02:34:57 INFO - 'LOGNAME': 'cltbld', 02:34:57 INFO - 'MAIL': '/var/mail/cltbld', 02:34:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:34:57 INFO - 'MOZ_NO_REMOTE': '1', 02:34:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:34:57 INFO - 'NO_EM_RESTART': '1', 02:34:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:34:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:34:57 INFO - 'PWD': '/builds/slave/test', 02:34:57 INFO - 'SHELL': '/bin/bash', 02:34:57 INFO - 'SHLVL': '1', 02:34:57 INFO - 'TERM': 'linux', 02:34:57 INFO - 'TMOUT': '86400', 02:34:57 INFO - 'USER': 'cltbld', 02:34:57 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1466674477.101294-1412096403', 02:34:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:34:57 INFO - '_': '/tools/buildbot/bin/python'} 02:34:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:34:58 INFO - Downloading/unpacking jsonschema==2.5.1 02:34:58 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:34:58 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:34:58 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:34:58 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:34:58 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:34:58 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:34:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:34:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:34:59 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:34:59 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:34:59 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:34:59 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:34:59 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:34:59 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:35:00 INFO - Downloading functools32-3.2.3-2.tar.gz 02:35:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:35:00 INFO - warning: no files found matching '*.txt' 02:35:00 INFO - no previously-included directories found matching 'build' 02:35:00 INFO - no previously-included directories found matching 'dist' 02:35:00 INFO - no previously-included directories found matching '.git*' 02:35:00 INFO - Installing collected packages: jsonschema, functools32 02:35:00 INFO - Running setup.py install for functools32 02:35:00 INFO - warning: no files found matching '*.txt' 02:35:00 INFO - no previously-included directories found matching 'build' 02:35:00 INFO - no previously-included directories found matching 'dist' 02:35:00 INFO - no previously-included directories found matching '.git*' 02:35:00 INFO - Successfully installed jsonschema functools32 02:35:00 INFO - Cleaning up... 02:35:00 INFO - Return code: 0 02:35:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:35:00 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:35:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:35:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:35:00 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:35:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:35:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:35:00 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 0x7f8d68dbdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ac350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283b1c0>, '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 0x283c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283c550>, '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': '3a3620fb28aea1604ab609ef000001d2-1466674477.101294-1412096403', '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:35:00 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:35:00 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:35:00 INFO - Using env: {'DISPLAY': ':0', 02:35:00 INFO - 'HOME': '/home/cltbld', 02:35:00 INFO - 'LANG': 'en_US.UTF-8', 02:35:00 INFO - 'LANGUAGE': 'en_US:en', 02:35:00 INFO - 'LOGNAME': 'cltbld', 02:35:00 INFO - 'MAIL': '/var/mail/cltbld', 02:35:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:35:00 INFO - 'MOZ_NO_REMOTE': '1', 02:35:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:35:00 INFO - 'NO_EM_RESTART': '1', 02:35:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:35:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:35:00 INFO - 'PWD': '/builds/slave/test', 02:35:00 INFO - 'SHELL': '/bin/bash', 02:35:00 INFO - 'SHLVL': '1', 02:35:00 INFO - 'TERM': 'linux', 02:35:00 INFO - 'TMOUT': '86400', 02:35:00 INFO - 'USER': 'cltbld', 02:35:00 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1466674477.101294-1412096403', 02:35:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:35:00 INFO - '_': '/tools/buildbot/bin/python'} 02:35:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:35:00 INFO - Downloading/unpacking blobuploader==1.2.4 02:35:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:35:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:35:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:35:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:35:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:35:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:35:02 INFO - Downloading blobuploader-1.2.4.tar.gz 02:35:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:35:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:35: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:35: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:35: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:35: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:35: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:35: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:35:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:35:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:35: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:35: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:35: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:35: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:35: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:35: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:35:03 INFO - Downloading docopt-0.6.1.tar.gz 02:35:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:35:03 INFO - Installing collected packages: blobuploader, requests, docopt 02:35:03 INFO - Running setup.py install for blobuploader 02:35:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:35:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:35:03 INFO - Running setup.py install for requests 02:35:03 INFO - Running setup.py install for docopt 02:35:03 INFO - Successfully installed blobuploader requests docopt 02:35:03 INFO - Cleaning up... 02:35:03 INFO - Return code: 0 02:35:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:35:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:35:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:35:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:35:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:35:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:35:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:35:03 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 0x7f8d68dbdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ac350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283b1c0>, '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 0x283c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283c550>, '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': '3a3620fb28aea1604ab609ef000001d2-1466674477.101294-1412096403', '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:35:03 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:35:03 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:35:03 INFO - Using env: {'DISPLAY': ':0', 02:35:03 INFO - 'HOME': '/home/cltbld', 02:35:03 INFO - 'LANG': 'en_US.UTF-8', 02:35:03 INFO - 'LANGUAGE': 'en_US:en', 02:35:03 INFO - 'LOGNAME': 'cltbld', 02:35:03 INFO - 'MAIL': '/var/mail/cltbld', 02:35:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:35:03 INFO - 'MOZ_NO_REMOTE': '1', 02:35:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:35:03 INFO - 'NO_EM_RESTART': '1', 02:35:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:35:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:35:03 INFO - 'PWD': '/builds/slave/test', 02:35:03 INFO - 'SHELL': '/bin/bash', 02:35:03 INFO - 'SHLVL': '1', 02:35:03 INFO - 'TERM': 'linux', 02:35:03 INFO - 'TMOUT': '86400', 02:35:03 INFO - 'USER': 'cltbld', 02:35:03 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1466674477.101294-1412096403', 02:35:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:35:03 INFO - '_': '/tools/buildbot/bin/python'} 02:35:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:35:04 INFO - Running setup.py (path:/tmp/pip-NHk4lN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:35:04 INFO - Running setup.py (path:/tmp/pip-rIBxiy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:35:04 INFO - Running setup.py (path:/tmp/pip-ERAdw0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:35:04 INFO - Running setup.py (path:/tmp/pip-56Wzsj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:35:04 INFO - Running setup.py (path:/tmp/pip-u428o9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:35:04 INFO - Running setup.py (path:/tmp/pip-sH4mn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:35:04 INFO - Running setup.py (path:/tmp/pip-gU7eFI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:35:04 INFO - Running setup.py (path:/tmp/pip-5jW9jW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:35:04 INFO - Running setup.py (path:/tmp/pip-pEi_VC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:35:04 INFO - Running setup.py (path:/tmp/pip-fqmO2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:35:04 INFO - Running setup.py (path:/tmp/pip-DIth9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:35:04 INFO - Running setup.py (path:/tmp/pip-6DXKAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:35:04 INFO - Running setup.py (path:/tmp/pip-YK7SiA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:35:05 INFO - Running setup.py (path:/tmp/pip-pnqGLf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:35:05 INFO - Running setup.py (path:/tmp/pip-VoGqFA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:35:05 INFO - Running setup.py (path:/tmp/pip-eUm7tw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:35:05 INFO - Running setup.py (path:/tmp/pip-6pW_ET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:35:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:35:05 INFO - Running setup.py install for manifestparser 02:35:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:35:05 INFO - Running setup.py install for mozcrash 02:35:05 INFO - Running setup.py install for mozdebug 02:35:05 INFO - Running setup.py install for mozdevice 02:35:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:35:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:35:05 INFO - Running setup.py install for mozfile 02:35:05 INFO - Running setup.py install for mozhttpd 02:35:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:35:05 INFO - Running setup.py install for mozinfo 02:35:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:35:06 INFO - Running setup.py install for mozInstall 02:35:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:35:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:35:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:35:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:35:06 INFO - Running setup.py install for mozleak 02:35:06 INFO - Running setup.py install for mozlog 02:35:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:35:06 INFO - Running setup.py install for moznetwork 02:35:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:35:06 INFO - Running setup.py install for mozprocess 02:35:06 INFO - Running setup.py install for mozprofile 02:35:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:35:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:35:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:35:06 INFO - Running setup.py install for mozrunner 02:35:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:35:06 INFO - Running setup.py install for mozscreenshot 02:35:06 INFO - Running setup.py install for moztest 02:35:06 INFO - Running setup.py install for mozversion 02:35:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:35:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:35:07 INFO - Cleaning up... 02:35:07 INFO - Return code: 0 02:35:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:35:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:35:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:35:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:35:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:35:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:35:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:35:07 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 0x7f8d68dbdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ac350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283b1c0>, '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 0x283c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283c550>, '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': '3a3620fb28aea1604ab609ef000001d2-1466674477.101294-1412096403', '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:35:07 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:35:07 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:35:07 INFO - Using env: {'DISPLAY': ':0', 02:35:07 INFO - 'HOME': '/home/cltbld', 02:35:07 INFO - 'LANG': 'en_US.UTF-8', 02:35:07 INFO - 'LANGUAGE': 'en_US:en', 02:35:07 INFO - 'LOGNAME': 'cltbld', 02:35:07 INFO - 'MAIL': '/var/mail/cltbld', 02:35:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:35:07 INFO - 'MOZ_NO_REMOTE': '1', 02:35:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:35:07 INFO - 'NO_EM_RESTART': '1', 02:35:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:35:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:35:07 INFO - 'PWD': '/builds/slave/test', 02:35:07 INFO - 'SHELL': '/bin/bash', 02:35:07 INFO - 'SHLVL': '1', 02:35:07 INFO - 'TERM': 'linux', 02:35:07 INFO - 'TMOUT': '86400', 02:35:07 INFO - 'USER': 'cltbld', 02:35:07 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1466674477.101294-1412096403', 02:35:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:35:07 INFO - '_': '/tools/buildbot/bin/python'} 02:35:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:35:07 INFO - Running setup.py (path:/tmp/pip-0Bczo9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:35:07 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:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:35:07 INFO - Running setup.py (path:/tmp/pip-raqu3B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:35:07 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:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:35:07 INFO - Running setup.py (path:/tmp/pip-lp_6Sg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:35:07 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:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:35:07 INFO - Running setup.py (path:/tmp/pip-mivBIj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:35:07 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:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:35:07 INFO - Running setup.py (path:/tmp/pip-GnCCQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:35:07 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:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:35:07 INFO - Running setup.py (path:/tmp/pip-JnTQkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:35:07 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:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:35:07 INFO - Running setup.py (path:/tmp/pip-LwVVsb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:35:07 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:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:35:07 INFO - Running setup.py (path:/tmp/pip-OSHHer-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:35:07 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:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:35:07 INFO - Running setup.py (path:/tmp/pip-HrZ7HD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:35:07 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:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:35:07 INFO - Running setup.py (path:/tmp/pip-7HmedE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:35:08 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:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:35:08 INFO - Running setup.py (path:/tmp/pip-9ofUfa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:35:08 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:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:35:08 INFO - Running setup.py (path:/tmp/pip-dCrxkv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:35:08 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:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:35:08 INFO - Running setup.py (path:/tmp/pip-kbBt7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:35:08 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:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:35:08 INFO - Running setup.py (path:/tmp/pip-g4nAH_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:35:08 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:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:35:08 INFO - Running setup.py (path:/tmp/pip-t8ujWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:35:08 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:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:35:08 INFO - Running setup.py (path:/tmp/pip-nv81rt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:35:08 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:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:35:08 INFO - Running setup.py (path:/tmp/pip-aHaOZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:35:08 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:35:08 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:35:08 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:35:08 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:35:08 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:35:08 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:35:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:35:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:35:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:35:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:35:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:35:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:35:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:35:10 INFO - Downloading blessings-1.6.tar.gz 02:35:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:35:10 INFO - Installing collected packages: blessings 02:35:10 INFO - Running setup.py install for blessings 02:35:10 INFO - Successfully installed blessings 02:35:10 INFO - Cleaning up... 02:35:10 INFO - Return code: 0 02:35:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:35:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:35:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:35:10 INFO - Reading from file tmpfile_stdout 02:35:10 INFO - Current package versions: 02:35:10 INFO - argparse == 1.2.1 02:35:10 INFO - blessings == 1.6 02:35:10 INFO - blobuploader == 1.2.4 02:35:10 INFO - docopt == 0.6.1 02:35:10 INFO - functools32 == 3.2.3-2 02:35:10 INFO - jsonschema == 2.5.1 02:35:10 INFO - manifestparser == 1.1 02:35:10 INFO - mozInstall == 1.12 02:35:10 INFO - mozcrash == 0.17 02:35:10 INFO - mozdebug == 0.1 02:35:10 INFO - mozdevice == 0.48 02:35:10 INFO - mozfile == 1.2 02:35:10 INFO - mozhttpd == 0.7 02:35:10 INFO - mozinfo == 0.9 02:35:10 INFO - mozleak == 0.1 02:35:10 INFO - mozlog == 3.2 02:35:10 INFO - moznetwork == 0.27 02:35:10 INFO - mozprocess == 0.22 02:35:10 INFO - mozprofile == 0.28 02:35:10 INFO - mozrunner == 6.11 02:35:10 INFO - mozscreenshot == 0.1 02:35:10 INFO - mozsystemmonitor == 0.3 02:35:10 INFO - moztest == 0.7 02:35:10 INFO - mozversion == 1.4 02:35:10 INFO - psutil == 3.1.1 02:35:10 INFO - requests == 1.2.3 02:35:10 INFO - wsgiref == 0.1.2 02:35:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:35:10 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:35:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:35:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:35:10 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:35:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:35:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:35:10 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 0x7f8d68dbdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ac350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283b1c0>, '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 0x283c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283c550>, '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': '3a3620fb28aea1604ab609ef000001d2-1466674477.101294-1412096403', '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:35:10 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:35:10 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:35:10 INFO - Using env: {'DISPLAY': ':0', 02:35:10 INFO - 'HOME': '/home/cltbld', 02:35:10 INFO - 'LANG': 'en_US.UTF-8', 02:35:10 INFO - 'LANGUAGE': 'en_US:en', 02:35:10 INFO - 'LOGNAME': 'cltbld', 02:35:10 INFO - 'MAIL': '/var/mail/cltbld', 02:35:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:35:10 INFO - 'MOZ_NO_REMOTE': '1', 02:35:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:35:10 INFO - 'NO_EM_RESTART': '1', 02:35:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:35:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:35:10 INFO - 'PWD': '/builds/slave/test', 02:35:10 INFO - 'SHELL': '/bin/bash', 02:35:10 INFO - 'SHLVL': '1', 02:35:10 INFO - 'TERM': 'linux', 02:35:10 INFO - 'TMOUT': '86400', 02:35:10 INFO - 'USER': 'cltbld', 02:35:10 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1466674477.101294-1412096403', 02:35:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:35:10 INFO - '_': '/tools/buildbot/bin/python'} 02:35:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:35:11 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:35:11 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:35:11 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:35:11 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:35:11 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:35:11 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:35:11 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:35:11 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:35:11 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:35:11 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:35:11 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:35:11 INFO - Cleaning up... 02:35:11 INFO - Return code: 0 02:35:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:35: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:35:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:35:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:35: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:35:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:35:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:35:11 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 0x7f8d68dbdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ac350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283b1c0>, '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 0x283c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283c550>, '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': '3a3620fb28aea1604ab609ef000001d2-1466674477.101294-1412096403', '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:35:11 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:35:11 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:35:11 INFO - Using env: {'DISPLAY': ':0', 02:35:11 INFO - 'HOME': '/home/cltbld', 02:35:11 INFO - 'LANG': 'en_US.UTF-8', 02:35:11 INFO - 'LANGUAGE': 'en_US:en', 02:35:11 INFO - 'LOGNAME': 'cltbld', 02:35:11 INFO - 'MAIL': '/var/mail/cltbld', 02:35:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:35:11 INFO - 'MOZ_NO_REMOTE': '1', 02:35:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:35:11 INFO - 'NO_EM_RESTART': '1', 02:35:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:35:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:35:11 INFO - 'PWD': '/builds/slave/test', 02:35:11 INFO - 'SHELL': '/bin/bash', 02:35:11 INFO - 'SHLVL': '1', 02:35:11 INFO - 'TERM': 'linux', 02:35:11 INFO - 'TMOUT': '86400', 02:35:11 INFO - 'USER': 'cltbld', 02:35:11 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1466674477.101294-1412096403', 02:35:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:35:11 INFO - '_': '/tools/buildbot/bin/python'} 02:35:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:35:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:35:11 INFO - Cleaning up... 02:35:11 INFO - Return code: 0 02:35:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:35: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:35:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:35:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:35: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:35:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:35:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:35:11 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 0x7f8d68dbdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27ac350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x283b1c0>, '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 0x283c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283c550>, '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': '3a3620fb28aea1604ab609ef000001d2-1466674477.101294-1412096403', '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:35:11 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:35:11 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:35:11 INFO - Using env: {'DISPLAY': ':0', 02:35:11 INFO - 'HOME': '/home/cltbld', 02:35:11 INFO - 'LANG': 'en_US.UTF-8', 02:35:11 INFO - 'LANGUAGE': 'en_US:en', 02:35:11 INFO - 'LOGNAME': 'cltbld', 02:35:11 INFO - 'MAIL': '/var/mail/cltbld', 02:35:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:35:11 INFO - 'MOZ_NO_REMOTE': '1', 02:35:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:35:11 INFO - 'NO_EM_RESTART': '1', 02:35:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:35:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:35:11 INFO - 'PWD': '/builds/slave/test', 02:35:11 INFO - 'SHELL': '/bin/bash', 02:35:11 INFO - 'SHLVL': '1', 02:35:11 INFO - 'TERM': 'linux', 02:35:11 INFO - 'TMOUT': '86400', 02:35:11 INFO - 'USER': 'cltbld', 02:35:11 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1466674477.101294-1412096403', 02:35:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:35:11 INFO - '_': '/tools/buildbot/bin/python'} 02:35:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:35:11 INFO - Downloading/unpacking flake8 02:35:11 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:35:11 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:35:11 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:35:11 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:35:11 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:35:11 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:35:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:35:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:35: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:35: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:35: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:35: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:35: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:35: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:35:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:35:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:35: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:35: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:35: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:35: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:35: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:35: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:35:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:35: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:35: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:35: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:35: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:35: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:35: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:35:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:35:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:35:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:35:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:35:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:35:14 INFO - no previously-included directories found matching 'docs/_build' 02:35:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:35:14 INFO - Running setup.py install for pep8 02:35:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:35:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:35:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:35:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:35:14 INFO - no previously-included directories found matching 'docs/_build' 02:35:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:35:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:35:14 INFO - Cleaning up... 02:35:14 INFO - Return code: 0 02:35:14 INFO - Running post-action listener: _resource_record_post_action 02:35:14 INFO - Running post-action listener: _start_resource_monitoring 02:35:14 INFO - Starting resource monitoring. 02:35:14 INFO - ##### 02:35:14 INFO - ##### Finished create-virtualenv step (success) 02:35:14 INFO - ##### 02:35:14 INFO - ##### 02:35:14 INFO - ##### Running install step. 02:35:14 INFO - ##### 02:35:14 INFO - Running pre-action listener: _resource_record_pre_action 02:35:14 INFO - Running main action method: install 02:35:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:35:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:35:14 INFO - Reading from file tmpfile_stdout 02:35:14 INFO - Detecting whether we're running mozinstall >=1.0... 02:35:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:35:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:35:14 INFO - Reading from file tmpfile_stdout 02:35:14 INFO - Output received: 02:35:14 INFO - Usage: mozinstall [options] installer 02:35:14 INFO - Options: 02:35:14 INFO - -h, --help show this help message and exit 02:35:14 INFO - -d DEST, --destination=DEST 02:35:14 INFO - Directory to install application into. [default: 02:35:14 INFO - "/builds/slave/test"] 02:35:14 INFO - --app=APP Application being installed. [default: firefox] 02:35:14 INFO - mkdir: /builds/slave/test/build/application 02:35:14 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:35:14 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:35:31 INFO - Reading from file tmpfile_stdout 02:35:31 INFO - Output received: 02:35:31 INFO - /builds/slave/test/build/application/firefox/firefox 02:35:31 INFO - Running post-action listener: _resource_record_post_action 02:35:31 INFO - ##### 02:35:31 INFO - ##### Finished install step (success) 02:35:31 INFO - ##### 02:35:31 INFO - ##### 02:35:31 INFO - ##### Running run-tests step. 02:35:31 INFO - ##### 02:35:31 INFO - Running pre-action listener: _resource_record_pre_action 02:35:31 INFO - Running main action method: run_tests 02:35:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:35:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:35:31 INFO - Python 2.7.3 02:35:31 INFO - Return code: 0 02:35:31 INFO - grabbing minidump binary from tooltool 02:35:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:35:31 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 0x283b1c0>, '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 0x283c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x283c550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:35:31 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:35:31 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:35:31 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:35:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:35:31 INFO - Return code: 0 02:35:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:35:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:35:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:35:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:35:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:35:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:35:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:35:32 INFO - Return code: 0 02:35:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M0c7I6k6SPGMfnUxsOzNCg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:35:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/M0c7I6k6SPGMfnUxsOzNCg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:35:32 INFO - Using env: {'DISPLAY': ':0', 02:35:32 INFO - 'HOME': '/home/cltbld', 02:35:32 INFO - 'LANG': 'en_US.UTF-8', 02:35:32 INFO - 'LANGUAGE': 'en_US:en', 02:35:32 INFO - 'LOGNAME': 'cltbld', 02:35:32 INFO - 'MAIL': '/var/mail/cltbld', 02:35:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:35:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:35:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:35:32 INFO - 'MOZ_NO_REMOTE': '1', 02:35:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:35:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:35:32 INFO - 'NO_EM_RESTART': '1', 02:35:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:35:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:35:32 INFO - 'PWD': '/builds/slave/test', 02:35:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:35:32 INFO - 'SHELL': '/bin/bash', 02:35:32 INFO - 'SHLVL': '1', 02:35:32 INFO - 'TERM': 'linux', 02:35:32 INFO - 'TMOUT': '86400', 02:35:32 INFO - 'USER': 'cltbld', 02:35:32 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1466674477.101294-1412096403', 02:35:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:35:32 INFO - '_': '/tools/buildbot/bin/python'} 02:35:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M0c7I6k6SPGMfnUxsOzNCg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:35:32 INFO - mozversion application_buildid: 20160622234707 02:35:32 INFO - mozversion application_changeset: 437fc937572dd344f58226d40ba9eccb4ffcaedb 02:35:32 INFO - mozversion application_display_name: Nightly 02:35:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:35:32 INFO - mozversion application_name: Firefox 02:35:32 INFO - mozversion application_remotingname: firefox 02:35:32 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:35:32 INFO - mozversion application_vendor: Mozilla 02:35:32 INFO - mozversion application_version: 50.0a1 02:35:32 INFO - mozversion platform_buildid: 20160622234707 02:35:32 INFO - mozversion platform_changeset: 437fc937572dd344f58226d40ba9eccb4ffcaedb 02:35:32 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:35:32 INFO - mozversion platform_version: 50.0a1 02:35:32 INFO - using testdate: 1466674532 02:35:32 INFO - actual date: 1466674532 02:35:32 INFO - starting webserver on 'localhost:40393' 02:35:32 INFO - SUITE-START | Running 2 tests 02:35:32 INFO - TEST-START | dromaeo_css 02:35:32 INFO - operating with platform_type : linux_ 02:35:32 INFO - Initialising browser for dromaeo_css test... 02:35:32 INFO - TEST-INFO | started process 21125 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8woM0x/profile http://localhost:40393/getInfo.html) 02:35:36 INFO - PROCESS | 21125 | __metrics Screen width/height:1600/1200 02:35:36 INFO - PROCESS | 21125 | colorDepth:24 02:35:36 INFO - PROCESS | 21125 | Browser inner width/height: 1024/697 02:35:36 INFO - PROCESS | 21125 | __metrics 02:35:37 INFO - PROCESS | 21125 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:35:38 INFO - TEST-INFO | 21125: exit 0 02:35:38 INFO - Browser initialized. 02:35:38 INFO - Running cycle 1/1 for dromaeo_css test... 02:35:38 INFO - TEST-INFO | started process 21206 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8woM0x/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:35:50 INFO - PROCESS | 21206 | RSS: Main: 174288896 02:35:50 INFO - PROCESS | 21206 | 02:36:42 INFO - PROCESS | 21206 | 1466674602119 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:38:49 INFO - PROCESS | 21206 | Cycle 1(1): loaded http://localhost:40393/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40393/tests/dromaeo/cssquery-ext.html) 02:38:50 INFO - PROCESS | 21206 | RSS: Main: 336379904 02:38:50 INFO - PROCESS | 21206 | 02:41:53 INFO - PROCESS | 21206 | Cycle 1(1): loaded http://localhost:40393/tests/dromaeo/cssquery-ext.html (next: http://localhost:40393/tests/dromaeo/cssquery-jquery.html) 02:41:54 INFO - PROCESS | 21206 | RSS: Main: 271187968 02:41:54 INFO - PROCESS | 21206 | 02:44:56 INFO - PROCESS | 21206 | Cycle 1(1): loaded http://localhost:40393/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40393/tests/dromaeo/cssquery-mootools.html) 02:44:56 INFO - PROCESS | 21206 | RSS: Main: 266723328 02:44:56 INFO - PROCESS | 21206 | 02:47:58 INFO - PROCESS | 21206 | Cycle 1(1): loaded http://localhost:40393/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40393/tests/dromaeo/cssquery-prototype.html) 02:47:59 INFO - PROCESS | 21206 | RSS: Main: 264433664 02:47:59 INFO - PROCESS | 21206 | 02:51:02 INFO - PROCESS | 21206 | Cycle 1(1): loaded http://localhost:40393/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40393/tests/dromaeo/cssquery-yui.html) 02:51:02 INFO - PROCESS | 21206 | RSS: Main: 239448064 02:51:02 INFO - PROCESS | 21206 | 02:54:05 INFO - PROCESS | 21206 | Cycle 1(1): loaded http://localhost:40393/tests/dromaeo/cssquery-yui.html (next: http://localhost:40393/tests/dromaeo/cssquery-dojo.html) 02:54:05 INFO - PROCESS | 21206 | RSS: Main: 297738240 02:54:05 INFO - PROCESS | 21206 | 02:54:05 INFO - PROCESS | 21206 | __start_tp_report 02:54:05 INFO - PROCESS | 21206 | _x_x_mozilla_page_load 02:54:05 INFO - PROCESS | 21206 | _x_x_mozilla_page_load_details 02:54:05 INFO - PROCESS | 21206 | |i|pagename|runs| 02:54:05 INFO - PROCESS | 21206 | |0;dojo.html;3061.1428799936025;3070.2631368471566;3095.5975723155993;3118.048995056507;3127.577777000106;5196;5207.9739601302035;5292.417834038252;5317.627766056373;5346.652467589604;5280.075986702331;5300.284461597683;5325.866853328659;5389.407165211834;5415.756290966906;4683.274092515666;4745.715257084568;4797.928031079537;4808.422989241296;4960.107180707471;4866.221404575269;4874.488178741234;4920.7785649645675;4921.360223170983;4953.0341583391255;4742.762861856893;4746.430428348603;4760.143174228655;4846.151923413388;4846.733429661367;4849.854504364839;4858.878528036792;4923;4938.728369939652;4970.502949705036;4721.598664113554;4885.364902562644;4902.90194196114;4910.754462276907;4948.356713627241;5338.199270109476;5409.783608655649;5410.83767486976;5451.972740136274;5484.698341591211;5849.532037436995;5854.970725146347;5866.061430171195;5872.941270587282;5875.706214689249;5497.367802702701;5647.632903861236;5893.970530147321;5913.9112913306335;5915.438033386865;5322.787088516455;5411.485908838654;5412.5940554458175;5417.214503896913;5418.512333889968;5845.970770146122;5847.619904706181;5859.765609375577;5859.853503662357;5861.589688721834;5448.155535891943;5461.9453805462235;5467.261919640877;5653.010723123519;5653.406392328829;5622.522085622768;5663.603547751618;5680.11958146488;5680.857978550486;5682.460166284196;5549.6115271931385;5592.468715472105;5603.551715862803;5605.747741351649;5611;5493.752781124859;5615.634983726045;5684.6589204647025;5748;5761.740721667451;4376.277914144194;4377.299632058855;4378.8029538670835;4381.67137464685;4413.58070983256;3912.9608703912595;3926.54844692864;3932.7050471214775;3964.7621142731527;3985.143194213258;5191.143461328838;5196.376434827845;5430.02259593277;5437.157240627709;5470.890582188334;5803.274590676166;5817.592768506249;5822.3304320003745;5827.650340979555;5860.2967643883;5471.4528547145765;5471.835844924659;5479.75341109651;5481.506664400223;5485;4824.228123500293;4924.926126108111;4972.154733695281;4990.90018199634;5016.673916195508;5995.400459954057;6006.429389208106;6007.098935159761;6013.218281623448;6013.278406591149;5616.522595579421;5771.394003629558;5799.9130013049;5805.564582656233;5805.767769289181;5829.854253643693;5841.357450680337;5849.853753656193;5894.528437725057;5945.494632956247;5550.500454959073;5578.804741834017;5593.412691667317;5593.580481463825;5598.272224610774;5346.809353943656;5695.487406133468;5707.714614269353;5710.086386178192;5710.65736055838;5353.571714262927;5424.918626220689;5427.755750991294;5429.972850135724;5442.156465747816;5397.217403476552;5400.05499037659;5404.8108316208745;5412.7564259607625;5414.3232095988005;5316.973415132899;5319.494648008433;5324.307839980777;5324.520793128482;5328.280682107866;5526.22632831412;5582.804601838916;5632.5775566831835;5677.3471050829685;5740.253767010262;5507.752151153128;5542.667439953616;5544.61187716856;5549.1676248563035;5604.607677462538 02:54:05 INFO - PROCESS | 21206 | |1;ext.html;616.8427051101968;622.1383384013141;636.1920361141349;641.4259237982009;643.6266965160205;42187.156256874885;43571.78214108929;43696.34455483167;48445.757771211094;48449.27326090103;45469.7726511367;45807.54192458074;45985.31022034672;46023.30965035527;46067;8972.416792908456;9114.954425227865;9126;9128.497932613704;9133.223675987549;8895.68865089722;9024.593893274818;9026.458412495238;9029.277657787394;9031.95484022579;8952.552372381355;9015.864762028576;9021.413608115485;9023.142801433853;9051.592678329458;9004.144606262395;9055.139761722627;9061.909380906172;9063.365564410495;9066.818663626756;8970.461772293618;9038.276937844958;9044.186023257938;9050;9055.230305424047;42262;42546.78726606378;42651;42667;42759;3707.7208363114682;3768.1898391845884;3771;3818.980905095457;4286.828526858922;32110.518342224885;32530.837345813357;33611.6638833611;33827.6617233827;34165.48751768725;4314.458406235096;4318.481782186158;4401.317795741666;4433.733975961452;4443.955560444387;348726.25636871904;348975;350002;350152;352760;50730;58297;59038.40961590415;59178.70410647919;59204.703976480705;63606;65110.67444662746;65434.672826635564;65506.34493655098;65578;17030.48908532746;17097.572560686083;17166.05586692719;17170.141492925304;17177.227024783664;12451.688707782378;12934.094613376974;13391.866081339256;13466.912628542592;13488.12327198729;15769.842301577068;16383.508494745176;16427.671446571003;16467.34130634785;16564.917175414288;6265.185525881606;6309.495240380758;6347.650879201688;6356.364363563699;6430.196225471816;912.0970239462883;993.9552720127612;1067.3062509368972;1108.5177947592822;1164.1036401970605;31594.368112637618;31918;32183.51724724131;32323.676763232535;32659.510107348407;1128.2779021426293;1134.1890548258036;1157.7047852797482;1173.7769823733463;1198.574506050357;16222.594435139215;16970.066646334322;17015.23431445588;17108.48674539766;17162.272761092336;530554;535278;536525;537174;537191;57557.424425755205;57854.42145578575;57911.420885790605;57940.71029644825;57968.13047804286;1245.1595173258015;1297.0272295778166;1320.7424552212226;1338.1770211319968;1360.2722543439213;29938.80244790184;31322.843385782926;33824.66175338215;33906.8304658485;34031.14922126967;50047.249291259934;50303;50315.74842125912;50357;50361.99999999854;468539;480434;482924;484008;486930;38029.2394152121;43482.78258608687;43595.78202108969;44843;45073;48785.75607121942;48988.265176021676;49447.25829112494;49721.75139124281;50226;42206;42358.78820605877;42842.14315713606;43394.78302608467;43750.78124609357;41209.58790412178;41843.581564183965;42112.57887421086;42217.577824221364;42296.15407691767;41034.79482602568;44001.77999109984;44406.55593444024;45218.547814522746;45366;37185.44221836729;38496.80751596224;38583.80708096441;38865.222695545366;39390;28360.574591380733;28528.714712853434;28743;28777.280567985967;28804.42391152207 02:54:05 INFO - PROCESS | 21206 | |2;jquery.html;369.1104438303688;374.3990894614144;376.23999520967647;384.17977617786016;392.39962856829044;17599.71418080049;19070;19461.708074378897;19732.70400943987;19775.307864224756;18196.727049094243;18251.452456426294;18952.810471895278;18993;19086.23655053796;5224.216367544861;5343.438938911417;5356.54469370104;5395.487428694268;5396.055690254209;5414.187871819239;5513.61404701671;5550.417206193352;5594.552435805146;5601.075822489284;5081.2886195932415;5551.666899985994;5561.972190139044;5565.2486914266665;5565.721713914288;5326.201069839516;5332.546733527635;5338.492843179892;5358.973205133969;5364.6781193128345;5110.872228194325;5315.73421328932;5357.8392648220615;5368.30212072432;5371.14061750122;21403.143874245012;21411.892940535352;21490.24784132548;22106.44733881666;22156.667649985262;2364.3261670424017;2374.8456350337174;2435.9512809743705;2524.8106392020673;2763.958540621892;8340.29107525861;8847.77880552985;9150.405223660508;9427;12611.243325400505;1822.735703323024;1963.1264087481077;1970.4384250488542;1980.5741765520481;1997.57052233769;46177.53822461766;53660.463395365936;53909;77661;83460;10236.62191476811;10250.538725757358;10548.525316360781;10769.892301076889;10835.67492975212;12210.26738395699;12985.480580776662;13077;13956.09285396446;14504.854951450561;7735.729249476354;7828.882566761503;7981.600919953979;8060.717874874351;8136.308413784776;7974.52152870818;8316.168383161756;8327.875081873777;8438.36712246584;8477.491350518989;4236.724612900151;4255.957440425618;4281.507626622916;4282.079352939133;4358.520562738159;1738.2525514028837;1751.246963805576;1773.1666116925026;1784.5003399048287;1906.4661894669514;916.4318122763929;974.9561269742878;995.5470261031213;1052.5263631365763;1091.49245600796;18071.457856264333;18810.341638042602;18939.526511837037;19066;19374;963.889152747429;982.1995074014656;991.1624677147798;995.3679413572289;1001.6694490818013;10402.635907743193;10518.842217366746;10612.840807387895;10642.25504214713;10664.466776661136;504515;511416;512232;519228;520303;89932.55033724921;90008.5499572498;90034.54982725045;91711.0828891716;94609.5269523648;933.2580598424269;949.6343907595488;973.0707174648336;984.2273815055147;987.3878195518824;16401.83598164003;16804.495865124067;16808.57978550546;16830.158492075592;16915.66168676644;30844;38427.42358864675;38530.6146938527;40306.79846600748;43484;54867.45132548623;55793.1631025543;56425.153622694874;62995.05507417484;63398;8257.133001034805;8434.156584341517;8625.094365091825;8635.87046194295;8718.956405217934;12468.189567678071;12690.175138615961;13592.32038398096;13607.319634018062;13923.303834808017;12049.277043377426;12224.87775122273;12346.444410001752;12409;12464.439100240692;5449.863753406196;12322.445489952794;12327.321997290235;12377.504899803907;12428.937855310665;11826.645200643994;11836.408179590813;11863.169578129447;12339.383030848243;12608.36958152107;7133.251008644018;7434.962825185839;8252.587370631565;8436.704715334934;8473.788155296166;11700.414979251174;11794;12144.878551214375;12319.753604927671;12370.13409061357 02:54:05 INFO - PROCESS | 21206 | |3;mootools.html;1321.8281623388957;1418.9290535473226;1463.9194844283563;1531.3262164647554;1713.631569212619;7591;7930.246626570481;7935.9286496322975;8183.6726530938695;8198.631061602227;7828.178041305652;8038.9196108038905;8043.235892590209;8044.155363686817;8045.879311810313;1915.817997290255;2149.4196566927;2195.999999999996;2230.5984922713906;2239;2259.8531095478825;2266.8639881607073;2268.8298377621663;2268.8411811173223;2271.2731925783755;2223.210760180137;2233.3300009996938;2248.4266512039408;2251.5159240763232;2251.797338239558;1848.8428483578846;2118.2797848731507;2170.251263314154;2177.716896803421;2182.563487302546;2164.8701077935375;2182.4216582605623;2197.9560408791895;2203.4821816873023;2204.0963205085836;8514.276286515653;8564.229219370225;8663.436876603;8674.522901240429;8687.044425113232;4919.385076865392;5068.011737711147;5068.898622027576;5070.2141168119;5072.594192464631;3223.580934478526;3239.5464634951127;3301.1912081540177;3304.322613864176;3308.024132880782;1091.2906610703028;1104.8508451359044;2124.2989813361555;2155;2180.531185795062;12029.759404811943;12160.391980400944;12190.695232619168;12202.694932626755;12206.267623942593;4206.47419072616;4289.506706728766;4379.211741886427;4379.64962802975;4394.494633117169;9318.30112741547;9341.2994025447;9355.625774968925;9368.203702685212;9372.95313523428;4988.6507944444265;5043.672161309503;5044.873878153002;5067.239914012927;5071.847844564669;4111.054457474797;4623.768811559408;4761.119192949315;4768.809247630056;4786.928196077061;3616.52985111939;3714.6285371462636;3738.12154143776;3746.737728359043;3835.980820095882;1059.5126241928645;1069.4599227390117;1071.0307172009343;1075.1667457720173;1098.5166526728215;785.1638005524098;869.426178722053;924.5377311344328;926.1479438916214;933.3373304953424;5362.329708786402;5545.805896793593;5591.440855914376;5643.717814109278;5678.290213723285;417.3822742341352;418.6567015047632;428.8820574342081;430.59093860832337;435.8801329634376;3724.329620668306;3876.903077423087;3923.2153569286256;3949.19041596472;3999.6600288975183;9897;10277.845832312521;10423.426711530787;10440.112590429746;10461.26771126029;10316.329438586468;10324.48377581133;10330.380177189392;10358.223133265035;10360.378377297386;7772.68909243624;7860.803479912934;7879.566623835744;7998.800029999296;8007.83984320322;5625.474370358728;5628.817948230917;5639.436056394492;5685.346185188756;5725;9478.573464194265;9715.659951901649;9726.027397260217;9831.066048725359;9841.212702983887;9453.43279403238;9749.122578967927;9783.559739811868;10039;10067.949660251652;6973;7616.543007419573;7730.884036739341;7803.492772969966;7896;8434.704785332484;8437.53593552336;8492.363072769444;8512.489250644734;8514.872276915976;7407.185209627044;7576.8484630308185;7640.083190017233;7659.961700191463;7708.306252437307;7508.2867127622785;7573.659185336784;7600.239976002355;7665.19515450892;7781.572013539309;6612.305707900794;6643.900341494978;6686.7993960181275;6687.063811066358;6690.02994565795;4778.259369797687;4954.1825598775795;5006.199008158677;5030.270610761492;5084.313617661568;4862.222044472867;4986.077575648516;5142.742862856768;5169.560587350117;5246.186841039645 02:54:05 INFO - PROCESS | 21206 | |4;prototype.html;273.5513757437802;274.12690580501106;281.16213683224;288.7877410103575;289.1383676643602;5103.311053007843;5248.239005344223;5305.70818604977;5327.653702509334;5346.652467589604;5203.635745497817;5250.763715632796;5259.710715910624;5269.6574722643;5273.314469119009;3828.942565861514;3926.7643941363467;3994.900127496807;4002.6597739192202;4016.7389119707273;3963.504561929759;4004.1391100913297;4006.298897692907;4014.478117844676;4019.4975628046495;3948.506436695413;3973.8807835764974;3978.9005274868214;3980.4029395590746;3992.7005474589523;3754.906127346811;3991.9201615967663;4013.418054382113;4030.496187976503;4032.213718324928;3416.760826742129;3424.280901010791;3432.2324003138406;3450.258194488197;3455.8963231103107;5107.438181799999;5110.565601923841;5119.948800511985;5148.639595228336;5198.54440756585;4372.868813935587;4544.954770353354;4565.840195593139;4567.543245675439;4581.862544123682;5409.2967914171295;5409.675419474805;5427.48438898304;5427.891442171134;5443.945560544384;3794.7723136611617;3794.9374175230705;3800.7339486235974;3801.8099095045413;3819.312523745725;5400.595845080268;5633.647924498132;5647.46349096831;5676.858078548069;5692.316921969349;3831;3834.827432765532;3845.8653947111716;3847.480590120354;3850.9229815403537;3886.5336159661024;3886.553046399644;3896;3908.335582950905;3931.6068393160454;4258.297380932174;4554.4990051094355;4557.111363284128;4586.197415452282;4592.747398893026;5142.125838607446;5517.862053448696;5536.501714845684;5557.3331200256225;5568.832935011957;1334.2194816032536;1334.9666258343618;1339.4642143142821;1350.540816122523;1352.749741297863;803.5299349880386;830.2983978538126;836.7280633794041;846.3018010141658;847.7541512961295;4725.763711814396;4784.760761961888;4816.4220293564995;4830.372051633265;4833.830815921426;4960.255961605788;4965.90068198634;4989.625778066659;5127.846164615067;5145.588352931756;4741.35991641124;4777.8088876445245;4817.421909370828;4834.758262086952;5038.748062596929;2990.970090299069;3028.2738838861637;3044.934273004431;3052.4810782167083;3066.1874603230162;5853.414658534112;5898;5908.852278692981;5926;5938.960681880653;5623.943760562342;5804.738786754606;5828.795992140254;5840.094785308199;5855.443732845373;5773.624714393551;5861.3552509223955;5884.235049443545;5890.322612899486;5900.380460051632;5383.461653834585;5677.375488696158;5692.373838877803;5716.199732037435;5724.542036636975;5632.239647647515;5643.689597072201;5664.773409063591;5667.773289068391;5678.346990096192;5602.411746766531;5742.28221472316;5873.676947767743;5875.882482350415;5883.529317654492;3839.481669974518;3879.670228030649;3885.5531613863636;3886.961130388773;3901.785401802928;5671.092625179951;5721.399253078367;5746.454086861741;5758.452946970031;5799.130130480462;5292.655977361459;5502.119660854244;5525.640833345819;5672.064109421899;5679.574031947538;5455.781768729206;5473.17902314656;5512.834614961557;5578.967890940189;5587.245721827664;5520.420355862577;5528.668279903219;5531.865967476738;5532.391436942014;5544.7227638618715;5451.536619387396;5513.255710479194;5554.722263886871;5570.637908535932;5586.608937374344;5439.700816455133;5452.945470545244;5467.152591348347;5481;5514.09017512106 02:54:05 INFO - PROCESS | 21206 | |5;yui.html;696.8118607975847;738.0774032459423;740.2745309596592;784.2745460449084;806.3831169155595;15267.23663816809;15960.32416596258;16240.83759162408;16581.170941452925;16605.58486037848;15138.318775655094;15147.469838555653;15290.235488225571;15291.388344466208;15305.693886122299;670.0451856105055;770.5800338815359;784.0317208247809;791.3787676673812;798.7284323330067;788.0779487999026;788.5111231036736;791.6121100660664;791.6951973490219;792.6670798264743;829.3489610655637;833.3208435125354;834.470111479209;834.8747687846841;835.7367429259764;686.800827759949;694.4583225084442;802.2058162419221;819.1890028871434;821.0352835418389;599.1611743559008;600.0848705723763;600.1088383750127;600.1897438458091;600.540586451365;15555.377784888591;15614.063156210665;15622.218889055503;15622.375104995786;15629.68740625181;13436.664083397896;13602.183868967795;13757.724845503133;13899.16605003703;14102.435902563886;12802.48790048397;13021.739565208738;13055.934720326337;13147.342632868318;13734.65663358414;4486.641068714528;4504.076664283814;4513.959598869528;4574.405327307462;4741.857744267643;65690.67154664244;69789;73374.63312683403;73502.26497735007;75590.62204688942;11691.401156598704;11740.178187526792;11880.643580692593;11930.88069119315;12141.089418293663;21596.4600884976;21682.566348673252;21685.457863553223;21714.674279885814;21722.78277217239;8583.270422014073;8711.303095752324;8809.647614095493;8848.203661670352;8867;4518.751468669189;4664.323673067386;4769.070031343924;4789.185838407479;4875.585575226075;3686.262747450467;3742.251549690073;3807.447920051577;3808.6953043756434;3809.5619003814363;653.4413076819251;656.3469347998772;669.6752075243503;671.8857794175002;689.5242282824835;668.2482207516543;691.9725205148961;711.5303899426353;781.0588241169377;786.2373497707215;9207.63169473227;9535.141837234682;9846.803063938682;10103.343282686601;10271.229657775697;615.3846153846154;704.8590281943632;711.1750369571273;729.4674887332277;742.5433358484493;4348.652107831366;4704.411948506437;4778.641601879804;4805.399325084364;4859.489753575895;69821.3017869825;74202.25797741953;105966;111623.44188279007;111663.44168279269;96128.51935740277;98481;99054;99066.5046674762;99144.50427747959;75616;75734.62132689302;88450;88579.55710221408;88703.11296886948;8366.24703776663;8479;8898.777530561529;8924.553772311228;8944.597493112695;51247.48752512427;51632.74183629208;51836;53307.73346133244;53784.73107634437;68594.31405686079;74264.62867685627;75988;77914.61042694977;78077.21922780927;11273.436328183721;11631.88368116342;11633.360165190996;11693.003832219643;12206.938965305117;13280.667983300495;13306.800397994231;13357.332133393485;13988.440462381392;14399.92800035993;12367.93816030914;12580.937095314832;12732.172408793398;12868.935655322039;13145.474181032652;12622.305773182563;12647.557335493213;13158.394561903257;13173.01202409804;13687.726245475234;11630.127740419672;12173;12434.502619895104;12550.43523041447;12998.415071321624;10473.528691208761;10526.157907367238;10638.202134839763;10814.729631759268;10982.890171098186;10192.439415832201;10195.337303075275;10706;10825.729356766144;10880.891191087987 02:54:05 INFO - PROCESS | 21206 | __end_tp_report 02:54:05 INFO - PROCESS | 21206 | __start_cc_report 02:54:05 INFO - PROCESS | 21206 | _x_x_mozilla_cycle_collect,1679 02:54:05 INFO - PROCESS | 21206 | __end_cc_report 02:54:05 INFO - PROCESS | 21206 | __startTimestamp1466675645956__endTimestamp 02:54:05 INFO - PROCESS | 21206 | 02:54:05 INFO - PROCESS | 21206 | ------- Summary: start ------- 02:54:05 INFO - PROCESS | 21206 | Number of tests: 6 02:54:05 INFO - PROCESS | 21206 | 02:54:05 INFO - PROCESS | 21206 | [#0] dojo.html Cycles:165 Average:5298.69 Median:5442.16 stddev:600.39 (11.0%) stddev-sans-first:576.00 02:54:05 INFO - PROCESS | 21206 | Values: 3061.1 3070.3 3095.6 3118.0 3127.6 5196.0 5208.0 5292.4 5317.6 5346.7 5280.1 5300.3 5325.9 5389.4 5415.8 4683.3 4745.7 4797.9 4808.4 4960.1 4866.2 4874.5 4920.8 4921.4 4953.0 4742.8 4746.4 4760.1 4846.2 4846.7 4849.9 4858.9 4923.0 4938.7 4970.5 4721.6 4885.4 4902.9 4910.8 4948.4 5338.2 5409.8 5410.8 5452.0 5484.7 5849.5 5855.0 5866.1 5872.9 5875.7 5497.4 5647.6 5894.0 5913.9 5915.4 5322.8 5411.5 5412.6 5417.2 5418.5 5846.0 5847.6 5859.8 5859.9 5861.6 5448.2 5461.9 5467.3 5653.0 5653.4 5622.5 5663.6 5680.1 5680.9 5682.5 5549.6 5592.5 5603.6 5605.7 5611.0 5493.8 5615.6 5684.7 5748.0 5761.7 4376.3 4377.3 4378.8 4381.7 4413.6 3913.0 3926.5 3932.7 3964.8 3985.1 5191.1 5196.4 5430.0 5437.2 5470.9 5803.3 5817.6 5822.3 5827.7 5860.3 5471.5 5471.8 5479.8 5481.5 5485.0 4824.2 4924.9 4972.2 4990.9 5016.7 5995.4 6006.4 6007.1 6013.2 6013.3 5616.5 5771.4 5799.9 5805.6 5805.8 5829.9 5841.4 5849.9 5894.5 5945.5 5550.5 5578.8 5593.4 5593.6 5598.3 5346.8 5695.5 5707.7 5710.1 5710.7 5353.6 5424.9 5427.8 5430.0 5442.2 5397.2 5400.1 5404.8 5412.8 5414.3 5317.0 5319.5 5324.3 5324.5 5328.3 5526.2 5582.8 5632.6 5677.3 5740.3 5507.8 5542.7 5544.6 5549.2 5604.6 02:54:05 INFO - PROCESS | 21206 | 02:54:05 INFO - PROCESS | 21206 | [#1] ext.html Cycles:180 Average:62335.32 Median:43723.56 stddev:122419.06 (280.0%) stddev-sans-first:122674.78 02:54:05 INFO - PROCESS | 21206 | Values: 616.8 622.1 636.2 641.4 643.6 42187.2 43571.8 43696.3 48445.8 48449.3 45469.8 45807.5 45985.3 46023.3 46067.0 8972.4 9115.0 9126.0 9128.5 9133.2 8895.7 9024.6 9026.5 9029.3 9032.0 8952.6 9015.9 9021.4 9023.1 9051.6 9004.1 9055.1 9061.9 9063.4 9066.8 8970.5 9038.3 9044.2 9050.0 9055.2 42262.0 42546.8 42651.0 42667.0 42759.0 3707.7 3768.2 3771.0 3819.0 4286.8 32110.5 32530.8 33611.7 33827.7 34165.5 4314.5 4318.5 4401.3 4433.7 4444.0 348726.3 348975.0 350002.0 350152.0 352760.0 50730.0 58297.0 59038.4 59178.7 59204.7 63606.0 65110.7 65434.7 65506.3 65578.0 17030.5 17097.6 17166.1 17170.1 17177.2 12451.7 12934.1 13391.9 13466.9 13488.1 15769.8 16383.5 16427.7 16467.3 16564.9 6265.2 6309.5 6347.7 6356.4 6430.2 912.1 994.0 1067.3 1108.5 1164.1 31594.4 31918.0 32183.5 32323.7 32659.5 1128.3 1134.2 1157.7 1173.8 1198.6 16222.6 16970.1 17015.2 17108.5 17162.3 530554.0 535278.0 536525.0 537174.0 537191.0 57557.4 57854.4 57911.4 57940.7 57968.1 1245.2 1297.0 1320.7 1338.2 1360.3 29938.8 31322.8 33824.7 33906.8 34031.1 50047.2 50303.0 50315.7 50357.0 50362.0 468539.0 480434.0 482924.0 484008.0 486930.0 38029.2 43482.8 43595.8 44843.0 45073.0 48785.8 48988.3 49447.3 49721.8 50226.0 42206.0 42358.8 42842.1 43394.8 43750.8 41209.6 41843.6 42112.6 42217.6 42296.2 41034.8 44001.8 44406.6 45218.5 45366.0 37185.4 38496.8 38583.8 38865.2 39390.0 28360.6 28528.7 28743.0 28777.3 28804.4 02:54:05 INFO - PROCESS | 21206 | 02:54:05 INFO - PROCESS | 21206 | [#2] jquery.html Cycles:180 Average:28842.30 Median:20349.60 stddev:84361.66 (414.6%) stddev-sans-first:84571.23 02:54:05 INFO - PROCESS | 21206 | Values: 369.1 374.4 376.2 384.2 392.4 17599.7 19070.0 19461.7 19732.7 19775.3 18196.7 18251.5 18952.8 18993.0 19086.2 5224.2 5343.4 5356.5 5395.5 5396.1 5414.2 5513.6 5550.4 5594.6 5601.1 5081.3 5551.7 5562.0 5565.2 5565.7 5326.2 5332.5 5338.5 5359.0 5364.7 5110.9 5315.7 5357.8 5368.3 5371.1 21403.1 21411.9 21490.2 22106.4 22156.7 2364.3 2374.8 2436.0 2524.8 2764.0 8340.3 8847.8 9150.4 9427.0 12611.2 1822.7 1963.1 1970.4 1980.6 1997.6 46177.5 53660.5 53909.0 77661.0 83460.0 10236.6 10250.5 10548.5 10769.9 10835.7 12210.3 12985.5 13077.0 13956.1 14504.9 7735.7 7828.9 7981.6 8060.7 8136.3 7974.5 8316.2 8327.9 8438.4 8477.5 4236.7 4256.0 4281.5 4282.1 4358.5 1738.3 1751.2 1773.2 1784.5 1906.5 916.4 975.0 995.5 1052.5 1091.5 18071.5 18810.3 18939.5 19066.0 19374.0 963.9 982.2 991.2 995.4 1001.7 10402.6 10518.8 10612.8 10642.3 10664.5 504515.0 511416.0 512232.0 519228.0 520303.0 89932.6 90008.5 90034.5 91711.1 94609.5 933.3 949.6 973.1 984.2 987.4 16401.8 16804.5 16808.6 16830.2 16915.7 30844.0 38427.4 38530.6 40306.8 43484.0 54867.5 55793.2 56425.2 62995.1 63398.0 8257.1 8434.2 8625.1 8635.9 8719.0 12468.2 12690.2 13592.3 13607.3 13923.3 12049.3 12224.9 12346.4 12409.0 12464.4 5449.9 12322.4 12327.3 12377.5 12428.9 11826.6 11836.4 11863.2 12339.4 12608.4 7133.3 7435.0 8252.6 8436.7 8473.8 11700.4 11794.0 12144.9 12319.8 12370.1 02:54:05 INFO - PROCESS | 21206 | 02:54:05 INFO - PROCESS | 21206 | [#3] mootools.html Cycles:180 Average:5552.87 Median:4987.36 stddev:3169.31 (63.5%) stddev-sans-first:3162.25 02:54:05 INFO - PROCESS | 21206 | Values: 1321.8 1418.9 1463.9 1531.3 1713.6 7591.0 7930.2 7935.9 8183.7 8198.6 7828.2 8038.9 8043.2 8044.2 8045.9 1915.8 2149.4 2196.0 2230.6 2239.0 2259.9 2266.9 2268.8 2268.8 2271.3 2223.2 2233.3 2248.4 2251.5 2251.8 1848.8 2118.3 2170.3 2177.7 2182.6 2164.9 2182.4 2198.0 2203.5 2204.1 8514.3 8564.2 8663.4 8674.5 8687.0 4919.4 5068.0 5068.9 5070.2 5072.6 3223.6 3239.5 3301.2 3304.3 3308.0 1091.3 1104.9 2124.3 2155.0 2180.5 12029.8 12160.4 12190.7 12202.7 12206.3 4206.5 4289.5 4379.2 4379.6 4394.5 9318.3 9341.3 9355.6 9368.2 9373.0 4988.7 5043.7 5044.9 5067.2 5071.8 4111.1 4623.8 4761.1 4768.8 4786.9 3616.5 3714.6 3738.1 3746.7 3836.0 1059.5 1069.5 1071.0 1075.2 1098.5 785.2 869.4 924.5 926.1 933.3 5362.3 5545.8 5591.4 5643.7 5678.3 417.4 418.7 428.9 430.6 435.9 3724.3 3876.9 3923.2 3949.2 3999.7 9897.0 10277.8 10423.4 10440.1 10461.3 10316.3 10324.5 10330.4 10358.2 10360.4 7772.7 7860.8 7879.6 7998.8 8007.8 5625.5 5628.8 5639.4 5685.3 5725.0 9478.6 9715.7 9726.0 9831.1 9841.2 9453.4 9749.1 9783.6 10039.0 10067.9 6973.0 7616.5 7730.9 7803.5 7896.0 8434.7 8437.5 8492.4 8512.5 8514.9 7407.2 7576.8 7640.1 7660.0 7708.3 7508.3 7573.7 7600.2 7665.2 7781.6 6612.3 6643.9 6686.8 6687.1 6690.0 4778.3 4954.2 5006.2 5030.3 5084.3 4862.2 4986.1 5142.7 5169.6 5246.2 02:54:05 INFO - PROCESS | 21206 | 02:54:05 INFO - PROCESS | 21206 | [#4] prototype.html Cycles:180 Average:4558.31 Median:5173.59 stddev:1387.50 (26.8%) stddev-sans-first:1353.61 02:54:05 INFO - PROCESS | 21206 | Values: 273.6 274.1 281.2 288.8 289.1 5103.3 5248.2 5305.7 5327.7 5346.7 5203.6 5250.8 5259.7 5269.7 5273.3 3828.9 3926.8 3994.9 4002.7 4016.7 3963.5 4004.1 4006.3 4014.5 4019.5 3948.5 3973.9 3978.9 3980.4 3992.7 3754.9 3991.9 4013.4 4030.5 4032.2 3416.8 3424.3 3432.2 3450.3 3455.9 5107.4 5110.6 5119.9 5148.6 5198.5 4372.9 4545.0 4565.8 4567.5 4581.9 5409.3 5409.7 5427.5 5427.9 5443.9 3794.8 3794.9 3800.7 3801.8 3819.3 5400.6 5633.6 5647.5 5676.9 5692.3 3831.0 3834.8 3845.9 3847.5 3850.9 3886.5 3886.6 3896.0 3908.3 3931.6 4258.3 4554.5 4557.1 4586.2 4592.7 5142.1 5517.9 5536.5 5557.3 5568.8 1334.2 1335.0 1339.5 1350.5 1352.7 803.5 830.3 836.7 846.3 847.8 4725.8 4784.8 4816.4 4830.4 4833.8 4960.3 4965.9 4989.6 5127.8 5145.6 4741.4 4777.8 4817.4 4834.8 5038.7 2991.0 3028.3 3044.9 3052.5 3066.2 5853.4 5898.0 5908.9 5926.0 5939.0 5623.9 5804.7 5828.8 5840.1 5855.4 5773.6 5861.4 5884.2 5890.3 5900.4 5383.5 5677.4 5692.4 5716.2 5724.5 5632.2 5643.7 5664.8 5667.8 5678.3 5602.4 5742.3 5873.7 5875.9 5883.5 3839.5 3879.7 3885.6 3887.0 3901.8 5671.1 5721.4 5746.5 5758.5 5799.1 5292.7 5502.1 5525.6 5672.1 5679.6 5455.8 5473.2 5512.8 5579.0 5587.2 5520.4 5528.7 5531.9 5532.4 5544.7 5451.5 5513.3 5554.7 5570.6 5586.6 5439.7 5452.9 5467.2 5481.0 5514.1 02:54:05 INFO - PROCESS | 21206 | 02:54:05 INFO - PROCESS | 21206 | [#5] yui.html Cycles:180 Average:19977.89 Median:4783.91 stddev:28069.94 (586.8%) stddev-sans-first:28111.35 02:54:05 INFO - PROCESS | 21206 | Values: 696.8 738.1 740.3 784.3 806.4 15267.2 15960.3 16240.8 16581.2 16605.6 15138.3 15147.5 15290.2 15291.4 15305.7 670.0 770.6 784.0 791.4 798.7 788.1 788.5 791.6 791.7 792.7 829.3 833.3 834.5 834.9 835.7 686.8 694.5 802.2 819.2 821.0 599.2 600.1 600.1 600.2 600.5 15555.4 15614.1 15622.2 15622.4 15629.7 13436.7 13602.2 13757.7 13899.2 14102.4 12802.5 13021.7 13055.9 13147.3 13734.7 4486.6 4504.1 4514.0 4574.4 4741.9 65690.7 69789.0 73374.6 73502.3 75590.6 11691.4 11740.2 11880.6 11930.9 12141.1 21596.5 21682.6 21685.5 21714.7 21722.8 8583.3 8711.3 8809.6 8848.2 8867.0 4518.8 4664.3 4769.1 4789.2 4875.6 3686.3 3742.3 3807.4 3808.7 3809.6 653.4 656.3 669.7 671.9 689.5 668.2 692.0 711.5 781.1 786.2 9207.6 9535.1 9846.8 10103.3 10271.2 615.4 704.9 711.2 729.5 742.5 4348.7 4704.4 4778.6 4805.4 4859.5 69821.3 74202.3 105966.0 111623.4 111663.4 96128.5 98481.0 99054.0 99066.5 99144.5 75616.0 75734.6 88450.0 88579.6 88703.1 8366.2 8479.0 8898.8 8924.6 8944.6 51247.5 51632.7 51836.0 53307.7 53784.7 68594.3 74264.6 75988.0 77914.6 78077.2 11273.4 11631.9 11633.4 11693.0 12206.9 13280.7 13306.8 13357.3 13988.4 14399.9 12367.9 12580.9 12732.2 12868.9 13145.5 12622.3 12647.6 13158.4 13173.0 13687.7 11630.1 12173.0 12434.5 12550.4 12998.4 10473.5 10526.2 10638.2 10814.7 10982.9 10192.4 10195.3 10706.0 10825.7 10880.9 02:54:05 INFO - PROCESS | 21206 | -------- Summary: end -------- 02:54:05 INFO - PROCESS | 21206 | 02:54:06 INFO - TEST-INFO | 21206: exit 0 02:54:06 INFO - TEST-OK | dromaeo_css | took 1113760ms 02:54:06 INFO - TEST-START | kraken 02:54:06 INFO - operating with platform_type : linux_ 02:54:06 INFO - Initialising browser for kraken test... 02:54:06 INFO - TEST-INFO | started process 21394 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTKYhaV/profile http://localhost:40393/getInfo.html) 02:54:10 INFO - PROCESS | 21394 | __metrics Screen width/height:1600/1200 02:54:10 INFO - PROCESS | 21394 | colorDepth:24 02:54:10 INFO - PROCESS | 21394 | Browser inner width/height: 1024/697 02:54:10 INFO - PROCESS | 21394 | __metrics 02:54:11 INFO - PROCESS | 21394 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:54:12 INFO - TEST-INFO | 21394: exit 0 02:54:12 INFO - Browser initialized. 02:54:12 INFO - Running cycle 1/1 for kraken test... 02:54:12 INFO - TEST-INFO | started process 21479 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTKYhaV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:54:24 INFO - PROCESS | 21479 | RSS: Main: 173604864 02:54:24 INFO - PROCESS | 21479 | 02:54:26 INFO - PROCESS | 21479 | Cycle 1(1): loaded http://localhost:40393/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40393/tests/kraken/driver.html?testName=audio-beat-detection) 02:54:27 INFO - PROCESS | 21479 | RSS: Main: 232120320 02:54:27 INFO - PROCESS | 21479 | 02:54:30 INFO - PROCESS | 21479 | Cycle 1(1): loaded http://localhost:40393/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40393/tests/kraken/driver.html?testName=audio-dft) 02:54:31 INFO - PROCESS | 21479 | RSS: Main: 222158848 02:54:31 INFO - PROCESS | 21479 | 02:54:34 INFO - PROCESS | 21479 | Cycle 1(1): loaded http://localhost:40393/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40393/tests/kraken/driver.html?testName=audio-fft) 02:54:34 INFO - PROCESS | 21479 | RSS: Main: 287121408 02:54:34 INFO - PROCESS | 21479 | 02:54:36 INFO - PROCESS | 21479 | Cycle 1(1): loaded http://localhost:40393/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40393/tests/kraken/driver.html?testName=audio-oscillator) 02:54:37 INFO - PROCESS | 21479 | RSS: Main: 198119424 02:54:37 INFO - PROCESS | 21479 | 02:54:39 INFO - PROCESS | 21479 | Cycle 1(1): loaded http://localhost:40393/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40393/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:54:40 INFO - PROCESS | 21479 | RSS: Main: 202493952 02:54:40 INFO - PROCESS | 21479 | 02:54:43 INFO - PROCESS | 21479 | Cycle 1(1): loaded http://localhost:40393/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40393/tests/kraken/driver.html?testName=imaging-darkroom) 02:54:43 INFO - PROCESS | 21479 | RSS: Main: 238399488 02:54:43 INFO - PROCESS | 21479 | 02:54:47 INFO - PROCESS | 21479 | Cycle 1(1): loaded http://localhost:40393/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40393/tests/kraken/driver.html?testName=imaging-desaturate) 02:54:47 INFO - PROCESS | 21479 | RSS: Main: 239349760 02:54:47 INFO - PROCESS | 21479 | 02:54:50 INFO - PROCESS | 21479 | Cycle 1(1): loaded http://localhost:40393/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40393/tests/kraken/driver.html?testName=json-parse-financial) 02:54:51 INFO - PROCESS | 21479 | RSS: Main: 239071232 02:54:51 INFO - PROCESS | 21479 | 02:54:52 INFO - PROCESS | 21479 | Cycle 1(1): loaded http://localhost:40393/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40393/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:54:53 INFO - PROCESS | 21479 | RSS: Main: 226410496 02:54:53 INFO - PROCESS | 21479 | 02:54:55 INFO - PROCESS | 21479 | Cycle 1(1): loaded http://localhost:40393/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40393/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:54:55 INFO - PROCESS | 21479 | RSS: Main: 230137856 02:54:55 INFO - PROCESS | 21479 | 02:54:57 INFO - PROCESS | 21479 | Cycle 1(1): loaded http://localhost:40393/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40393/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:54:58 INFO - PROCESS | 21479 | RSS: Main: 237117440 02:54:58 INFO - PROCESS | 21479 | 02:55:01 INFO - PROCESS | 21479 | Cycle 1(1): loaded http://localhost:40393/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40393/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:55:01 INFO - PROCESS | 21479 | RSS: Main: 251916288 02:55:01 INFO - PROCESS | 21479 | 02:55:04 INFO - PROCESS | 21479 | Cycle 1(1): loaded http://localhost:40393/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40393/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:55:05 INFO - PROCESS | 21479 | RSS: Main: 245481472 02:55:05 INFO - PROCESS | 21479 | 02:55:06 INFO - PROCESS | 21479 | Cycle 1(1): loaded http://localhost:40393/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40393/tests/kraken/driver.html?testName=ai-astar) 02:55:06 INFO - PROCESS | 21479 | RSS: Main: 288534528 02:55:06 INFO - PROCESS | 21479 | 02:55:06 INFO - PROCESS | 21479 | __start_tp_report 02:55:06 INFO - PROCESS | 21479 | _x_x_mozilla_page_load 02:55:06 INFO - PROCESS | 21479 | _x_x_mozilla_page_load_details 02:55:06 INFO - PROCESS | 21479 | |i|pagename|runs| 02:55:06 INFO - PROCESS | 21479 | |0;ai-astar;104;111;111;110;110;113;111;110;110;109 02:55:06 INFO - PROCESS | 21479 | |1;audio-beat-detection;152;125;135;169;128;128;157;132;169;124 02:55:06 INFO - PROCESS | 21479 | |2;audio-dft;161;162;171;162;161;164;163;163;163;162 02:55:06 INFO - PROCESS | 21479 | |3;audio-fft;74;75;77;131;75;75;74;75;97;75 02:55:06 INFO - PROCESS | 21479 | |4;audio-oscillator;85;85;117;87;86;84;122;87;86;130 02:55:06 INFO - PROCESS | 21479 | |5;imaging-gaussian-blur;117;117;117;117;118;117;117;117;117;117 02:55:06 INFO - PROCESS | 21479 | |6;imaging-darkroom;146;146;145;146;146;146;146;146;146;146 02:55:06 INFO - PROCESS | 21479 | |7;imaging-desaturate;95;95;94;95;95;95;95;95;95;95 02:55:06 INFO - PROCESS | 21479 | |8;json-parse-financial;53;54;53;52;52;53;54;53;52;53 02:55:06 INFO - PROCESS | 21479 | |9;json-stringify-tinderbox;61;61;61;62;62;61;61;61;61;61 02:55:06 INFO - PROCESS | 21479 | |10;stanford-crypto-aes;78;78;79;78;78;79;80;81;148;79 02:55:06 INFO - PROCESS | 21479 | |11;stanford-crypto-ccm;132;131;130;117;132;132;130;123;133;128 02:55:06 INFO - PROCESS | 21479 | |12;stanford-crypto-pbkdf2;162;161;161;162;162;158;161;161;163;158 02:55:06 INFO - PROCESS | 21479 | |13;stanford-crypto-sha256-iterative;62;64;62;62;63;64;63;61;62;67 02:55:06 INFO - PROCESS | 21479 | __end_tp_report 02:55:06 INFO - PROCESS | 21479 | __start_cc_report 02:55:06 INFO - PROCESS | 21479 | _x_x_mozilla_cycle_collect,1647 02:55:06 INFO - PROCESS | 21479 | __end_cc_report 02:55:06 INFO - PROCESS | 21479 | __startTimestamp1466675706908__endTimestamp 02:55:06 INFO - PROCESS | 21479 | 02:55:06 INFO - PROCESS | 21479 | ------- Summary: start ------- 02:55:06 INFO - PROCESS | 21479 | Number of tests: 14 02:55:06 INFO - PROCESS | 21479 | 02:55:06 INFO - PROCESS | 21479 | [#0] ai-astar Cycles:10 Average:109.90 Median:110.50 stddev:2.33 (2.1%) stddev-sans-first:1.13 02:55:06 INFO - PROCESS | 21479 | Values: 104.0 111.0 111.0 110.0 110.0 113.0 111.0 110.0 110.0 109.0 02:55:06 INFO - PROCESS | 21479 | 02:55:06 INFO - PROCESS | 21479 | [#1] audio-beat-detection Cycles:10 Average:141.90 Median:143.50 stddev:18.06 (12.6%) stddev-sans-first:18.79 02:55:06 INFO - PROCESS | 21479 | Values: 152.0 125.0 135.0 169.0 128.0 128.0 157.0 132.0 169.0 124.0 02:55:06 INFO - PROCESS | 21479 | 02:55:06 INFO - PROCESS | 21479 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.00 stddev:2.90 (1.8%) stddev-sans-first:2.96 02:55:06 INFO - PROCESS | 21479 | Values: 161.0 162.0 171.0 162.0 161.0 164.0 163.0 163.0 163.0 162.0 02:55:06 INFO - PROCESS | 21479 | 02:55:06 INFO - PROCESS | 21479 | [#3] audio-fft Cycles:10 Average:82.80 Median:75.00 stddev:18.31 (24.4%) stddev-sans-first:19.14 02:55:06 INFO - PROCESS | 21479 | Values: 74.0 75.0 77.0 131.0 75.0 75.0 74.0 75.0 97.0 75.0 02:55:06 INFO - PROCESS | 21479 | 02:55:06 INFO - PROCESS | 21479 | [#4] audio-oscillator Cycles:10 Average:96.90 Median:85.50 stddev:18.30 (21.4%) stddev-sans-first:18.89 02:55:06 INFO - PROCESS | 21479 | Values: 85.0 85.0 117.0 87.0 86.0 84.0 122.0 87.0 86.0 130.0 02:55:06 INFO - PROCESS | 21479 | 02:55:06 INFO - PROCESS | 21479 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 02:55:06 INFO - PROCESS | 21479 | Values: 117.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 02:55:06 INFO - PROCESS | 21479 | 02:55:06 INFO - PROCESS | 21479 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 02:55:06 INFO - PROCESS | 21479 | Values: 146.0 146.0 145.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 02:55:06 INFO - PROCESS | 21479 | 02:55:06 INFO - PROCESS | 21479 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 02:55:06 INFO - PROCESS | 21479 | Values: 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 02:55:06 INFO - PROCESS | 21479 | 02:55:06 INFO - PROCESS | 21479 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:53.00 stddev:0.74 (1.4%) stddev-sans-first:0.78 02:55:06 INFO - PROCESS | 21479 | Values: 53.0 54.0 53.0 52.0 52.0 53.0 54.0 53.0 52.0 53.0 02:55:06 INFO - PROCESS | 21479 | 02:55:06 INFO - PROCESS | 21479 | [#9] json-stringify-tinderbox Cycles:10 Average:61.20 Median:61.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 02:55:06 INFO - PROCESS | 21479 | Values: 61.0 61.0 61.0 62.0 62.0 61.0 61.0 61.0 61.0 61.0 02:55:06 INFO - PROCESS | 21479 | 02:55:06 INFO - PROCESS | 21479 | [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:79.00 stddev:21.88 (27.7%) stddev-sans-first:23.02 02:55:06 INFO - PROCESS | 21479 | Values: 78.0 78.0 79.0 78.0 78.0 79.0 80.0 81.0 148.0 79.0 02:55:06 INFO - PROCESS | 21479 | 02:55:06 INFO - PROCESS | 21479 | [#11] stanford-crypto-ccm Cycles:10 Average:128.80 Median:131.50 stddev:5.05 (3.8%) stddev-sans-first:5.22 02:55:06 INFO - PROCESS | 21479 | Values: 132.0 131.0 130.0 117.0 132.0 132.0 130.0 123.0 133.0 128.0 02:55:06 INFO - PROCESS | 21479 | 02:55:06 INFO - PROCESS | 21479 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.90 Median:161.50 stddev:1.66 (1.0%) stddev-sans-first:1.72 02:55:06 INFO - PROCESS | 21479 | Values: 162.0 161.0 161.0 162.0 162.0 158.0 161.0 161.0 163.0 158.0 02:55:06 INFO - PROCESS | 21479 | 02:55:06 INFO - PROCESS | 21479 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:63.00 stddev:1.70 (2.7%) stddev-sans-first:1.76 02:55:06 INFO - PROCESS | 21479 | Values: 62.0 64.0 62.0 62.0 63.0 64.0 63.0 61.0 62.0 67.0 02:55:06 INFO - PROCESS | 21479 | -------- Summary: end -------- 02:55:06 INFO - PROCESS | 21479 | 02:55:07 INFO - TEST-INFO | 21479: exit 0 02:55:07 INFO - TEST-OK | kraken | took 61150ms 02:55:07 INFO - SUITE-END | took 1174s 02:55:08 INFO - Completed test suite (00:19:35) 02:55:08 INFO - javascript benchmark 02:55:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3061.1428799936025, 3070.2631368471566, 3095.5975723155993, 3118.048995056507, 3127.577777000106, 5196.0, 5207.9739601302035, 5292.417834038252, 5317.627766056373, 5346.652467589604, 5280.075986702331, 5300.284461597683, 5325.866853328659, 5389.407165211834, 5415.756290966906, 4683.274092515666, 4745.715257084568, 4797.928031079537, 4808.422989241296, 4960.107180707471, 4866.221404575269, 4874.488178741234, 4920.7785649645675, 4921.360223170983, 4953.0341583391255, 4742.762861856893, 4746.430428348603, 4760.143174228655, 4846.151923413388, 4846.733429661367, 4849.854504364839, 4858.878528036792, 4923.0, 4938.728369939652, 4970.502949705036, 4721.598664113554, 4885.364902562644, 4902.90194196114, 4910.754462276907, 4948.356713627241, 5338.199270109476, 5409.783608655649, 5410.83767486976, 5451.972740136274, 5484.698341591211, 5849.532037436995, 5854.970725146347, 5866.061430171195, 5872.941270587282, 5875.706214689249, 5497.367802702701, 5647.632903861236, 5893.970530147321, 5913.9112913306335, 5915.438033386865, 5322.787088516455, 5411.485908838654, 5412.5940554458175, 5417.214503896913, 5418.512333889968, 5845.970770146122, 5847.619904706181, 5859.765609375577, 5859.853503662357, 5861.589688721834, 5448.155535891943, 5461.9453805462235, 5467.261919640877, 5653.010723123519, 5653.406392328829, 5622.522085622768, 5663.603547751618, 5680.11958146488, 5680.857978550486, 5682.460166284196, 5549.6115271931385, 5592.468715472105, 5603.551715862803, 5605.747741351649, 5611.0, 5493.752781124859, 5615.634983726045, 5684.6589204647025, 5748.0, 5761.740721667451, 4376.277914144194, 4377.299632058855, 4378.8029538670835, 4381.67137464685, 4413.58070983256, 3912.9608703912595, 3926.54844692864, 3932.7050471214775, 3964.7621142731527, 3985.143194213258, 5191.143461328838, 5196.376434827845, 5430.02259593277, 5437.157240627709, 5470.890582188334, 5803.274590676166, 5817.592768506249, 5822.3304320003745, 5827.650340979555, 5860.2967643883, 5471.4528547145765, 5471.835844924659, 5479.75341109651, 5481.506664400223, 5485.0, 4824.228123500293, 4924.926126108111, 4972.154733695281, 4990.90018199634, 5016.673916195508, 5995.400459954057, 6006.429389208106, 6007.098935159761, 6013.218281623448, 6013.278406591149, 5616.522595579421, 5771.394003629558, 5799.9130013049, 5805.564582656233, 5805.767769289181, 5829.854253643693, 5841.357450680337, 5849.853753656193, 5894.528437725057, 5945.494632956247, 5550.500454959073, 5578.804741834017, 5593.412691667317, 5593.580481463825, 5598.272224610774, 5346.809353943656, 5695.487406133468, 5707.714614269353, 5710.086386178192, 5710.65736055838, 5353.571714262927, 5424.918626220689, 5427.755750991294, 5429.972850135724, 5442.156465747816, 5397.217403476552, 5400.05499037659, 5404.8108316208745, 5412.7564259607625, 5414.3232095988005, 5316.973415132899, 5319.494648008433, 5324.307839980777, 5324.520793128482, 5328.280682107866, 5526.22632831412, 5582.804601838916, 5632.5775566831835, 5677.3471050829685, 5740.253767010262, 5507.752151153128, 5542.667439953616, 5544.61187716856, 5549.1676248563035, 5604.607677462538], "value": 5258.648552120302, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [616.8427051101968, 622.1383384013141, 636.1920361141349, 641.4259237982009, 643.6266965160205, 42187.156256874885, 43571.78214108929, 43696.34455483167, 48445.757771211094, 48449.27326090103, 45469.7726511367, 45807.54192458074, 45985.31022034672, 46023.30965035527, 46067.0, 8972.416792908456, 9114.954425227865, 9126.0, 9128.497932613704, 9133.223675987549, 8895.68865089722, 9024.593893274818, 9026.458412495238, 9029.277657787394, 9031.95484022579, 8952.552372381355, 9015.864762028576, 9021.413608115485, 9023.142801433853, 9051.592678329458, 9004.144606262395, 9055.139761722627, 9061.909380906172, 9063.365564410495, 9066.818663626756, 8970.461772293618, 9038.276937844958, 9044.186023257938, 9050.0, 9055.230305424047, 42262.0, 42546.78726606378, 42651.0, 42667.0, 42759.0, 3707.7208363114682, 3768.1898391845884, 3771.0, 3818.980905095457, 4286.828526858922, 32110.518342224885, 32530.837345813357, 33611.6638833611, 33827.6617233827, 34165.48751768725, 4314.458406235096, 4318.481782186158, 4401.317795741666, 4433.733975961452, 4443.955560444387, 348726.25636871904, 348975.0, 350002.0, 350152.0, 352760.0, 50730.0, 58297.0, 59038.40961590415, 59178.70410647919, 59204.703976480705, 63606.0, 65110.67444662746, 65434.672826635564, 65506.34493655098, 65578.0, 17030.48908532746, 17097.572560686083, 17166.05586692719, 17170.141492925304, 17177.227024783664, 12451.688707782378, 12934.094613376974, 13391.866081339256, 13466.912628542592, 13488.12327198729, 15769.842301577068, 16383.508494745176, 16427.671446571003, 16467.34130634785, 16564.917175414288, 6265.185525881606, 6309.495240380758, 6347.650879201688, 6356.364363563699, 6430.196225471816, 912.0970239462883, 993.9552720127612, 1067.3062509368972, 1108.5177947592822, 1164.1036401970605, 31594.368112637618, 31918.0, 32183.51724724131, 32323.676763232535, 32659.510107348407, 1128.2779021426293, 1134.1890548258036, 1157.7047852797482, 1173.7769823733463, 1198.574506050357, 16222.594435139215, 16970.066646334322, 17015.23431445588, 17108.48674539766, 17162.272761092336, 530554.0, 535278.0, 536525.0, 537174.0, 537191.0, 57557.424425755205, 57854.42145578575, 57911.420885790605, 57940.71029644825, 57968.13047804286, 1245.1595173258015, 1297.0272295778166, 1320.7424552212226, 1338.1770211319968, 1360.2722543439213, 29938.80244790184, 31322.843385782926, 33824.66175338215, 33906.8304658485, 34031.14922126967, 50047.249291259934, 50303.0, 50315.74842125912, 50357.0, 50361.99999999854, 468539.0, 480434.0, 482924.0, 484008.0, 486930.0, 38029.2394152121, 43482.78258608687, 43595.78202108969, 44843.0, 45073.0, 48785.75607121942, 48988.265176021676, 49447.25829112494, 49721.75139124281, 50226.0, 42206.0, 42358.78820605877, 42842.14315713606, 43394.78302608467, 43750.78124609357, 41209.58790412178, 41843.581564183965, 42112.57887421086, 42217.577824221364, 42296.15407691767, 41034.79482602568, 44001.77999109984, 44406.55593444024, 45218.547814522746, 45366.0, 37185.44221836729, 38496.80751596224, 38583.80708096441, 38865.222695545366, 39390.0, 28360.574591380733, 28528.714712853434, 28743.0, 28777.280567985967, 28804.42391152207], "value": 20676.860787753983, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.1104438303688, 374.3990894614144, 376.23999520967647, 384.17977617786016, 392.39962856829044, 17599.71418080049, 19070.0, 19461.708074378897, 19732.70400943987, 19775.307864224756, 18196.727049094243, 18251.452456426294, 18952.810471895278, 18993.0, 19086.23655053796, 5224.216367544861, 5343.438938911417, 5356.54469370104, 5395.487428694268, 5396.055690254209, 5414.187871819239, 5513.61404701671, 5550.417206193352, 5594.552435805146, 5601.075822489284, 5081.2886195932415, 5551.666899985994, 5561.972190139044, 5565.2486914266665, 5565.721713914288, 5326.201069839516, 5332.546733527635, 5338.492843179892, 5358.973205133969, 5364.6781193128345, 5110.872228194325, 5315.73421328932, 5357.8392648220615, 5368.30212072432, 5371.14061750122, 21403.143874245012, 21411.892940535352, 21490.24784132548, 22106.44733881666, 22156.667649985262, 2364.3261670424017, 2374.8456350337174, 2435.9512809743705, 2524.8106392020673, 2763.958540621892, 8340.29107525861, 8847.77880552985, 9150.405223660508, 9427.0, 12611.243325400505, 1822.735703323024, 1963.1264087481077, 1970.4384250488542, 1980.5741765520481, 1997.57052233769, 46177.53822461766, 53660.463395365936, 53909.0, 77661.0, 83460.0, 10236.62191476811, 10250.538725757358, 10548.525316360781, 10769.892301076889, 10835.67492975212, 12210.26738395699, 12985.480580776662, 13077.0, 13956.09285396446, 14504.854951450561, 7735.729249476354, 7828.882566761503, 7981.600919953979, 8060.717874874351, 8136.308413784776, 7974.52152870818, 8316.168383161756, 8327.875081873777, 8438.36712246584, 8477.491350518989, 4236.724612900151, 4255.957440425618, 4281.507626622916, 4282.079352939133, 4358.520562738159, 1738.2525514028837, 1751.246963805576, 1773.1666116925026, 1784.5003399048287, 1906.4661894669514, 916.4318122763929, 974.9561269742878, 995.5470261031213, 1052.5263631365763, 1091.49245600796, 18071.457856264333, 18810.341638042602, 18939.526511837037, 19066.0, 19374.0, 963.889152747429, 982.1995074014656, 991.1624677147798, 995.3679413572289, 1001.6694490818013, 10402.635907743193, 10518.842217366746, 10612.840807387895, 10642.25504214713, 10664.466776661136, 504515.0, 511416.0, 512232.0, 519228.0, 520303.0, 89932.55033724921, 90008.5499572498, 90034.54982725045, 91711.0828891716, 94609.5269523648, 933.2580598424269, 949.6343907595488, 973.0707174648336, 984.2273815055147, 987.3878195518824, 16401.83598164003, 16804.495865124067, 16808.57978550546, 16830.158492075592, 16915.66168676644, 30844.0, 38427.42358864675, 38530.6146938527, 40306.79846600748, 43484.0, 54867.45132548623, 55793.1631025543, 56425.153622694874, 62995.05507417484, 63398.0, 8257.133001034805, 8434.156584341517, 8625.094365091825, 8635.87046194295, 8718.956405217934, 12468.189567678071, 12690.175138615961, 13592.32038398096, 13607.319634018062, 13923.303834808017, 12049.277043377426, 12224.87775122273, 12346.444410001752, 12409.0, 12464.439100240692, 5449.863753406196, 12322.445489952794, 12327.321997290235, 12377.504899803907, 12428.937855310665, 11826.645200643994, 11836.408179590813, 11863.169578129447, 12339.383030848243, 12608.36958152107, 7133.251008644018, 7434.962825185839, 8252.587370631565, 8436.704715334934, 8473.788155296166, 11700.414979251174, 11794.0, 12144.878551214375, 12319.753604927671, 12370.13409061357], "value": 8930.882684517259, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1321.8281623388957, 1418.9290535473226, 1463.9194844283563, 1531.3262164647554, 1713.631569212619, 7591.0, 7930.246626570481, 7935.9286496322975, 8183.6726530938695, 8198.631061602227, 7828.178041305652, 8038.9196108038905, 8043.235892590209, 8044.155363686817, 8045.879311810313, 1915.817997290255, 2149.4196566927, 2195.999999999996, 2230.5984922713906, 2239.0, 2259.8531095478825, 2266.8639881607073, 2268.8298377621663, 2268.8411811173223, 2271.2731925783755, 2223.210760180137, 2233.3300009996938, 2248.4266512039408, 2251.5159240763232, 2251.797338239558, 1848.8428483578846, 2118.2797848731507, 2170.251263314154, 2177.716896803421, 2182.563487302546, 2164.8701077935375, 2182.4216582605623, 2197.9560408791895, 2203.4821816873023, 2204.0963205085836, 8514.276286515653, 8564.229219370225, 8663.436876603, 8674.522901240429, 8687.044425113232, 4919.385076865392, 5068.011737711147, 5068.898622027576, 5070.2141168119, 5072.594192464631, 3223.580934478526, 3239.5464634951127, 3301.1912081540177, 3304.322613864176, 3308.024132880782, 1091.2906610703028, 1104.8508451359044, 2124.2989813361555, 2155.0, 2180.531185795062, 12029.759404811943, 12160.391980400944, 12190.695232619168, 12202.694932626755, 12206.267623942593, 4206.47419072616, 4289.506706728766, 4379.211741886427, 4379.64962802975, 4394.494633117169, 9318.30112741547, 9341.2994025447, 9355.625774968925, 9368.203702685212, 9372.95313523428, 4988.6507944444265, 5043.672161309503, 5044.873878153002, 5067.239914012927, 5071.847844564669, 4111.054457474797, 4623.768811559408, 4761.119192949315, 4768.809247630056, 4786.928196077061, 3616.52985111939, 3714.6285371462636, 3738.12154143776, 3746.737728359043, 3835.980820095882, 1059.5126241928645, 1069.4599227390117, 1071.0307172009343, 1075.1667457720173, 1098.5166526728215, 785.1638005524098, 869.426178722053, 924.5377311344328, 926.1479438916214, 933.3373304953424, 5362.329708786402, 5545.805896793593, 5591.440855914376, 5643.717814109278, 5678.290213723285, 417.3822742341352, 418.6567015047632, 428.8820574342081, 430.59093860832337, 435.8801329634376, 3724.329620668306, 3876.903077423087, 3923.2153569286256, 3949.19041596472, 3999.6600288975183, 9897.0, 10277.845832312521, 10423.426711530787, 10440.112590429746, 10461.26771126029, 10316.329438586468, 10324.48377581133, 10330.380177189392, 10358.223133265035, 10360.378377297386, 7772.68909243624, 7860.803479912934, 7879.566623835744, 7998.800029999296, 8007.83984320322, 5625.474370358728, 5628.817948230917, 5639.436056394492, 5685.346185188756, 5725.0, 9478.573464194265, 9715.659951901649, 9726.027397260217, 9831.066048725359, 9841.212702983887, 9453.43279403238, 9749.122578967927, 9783.559739811868, 10039.0, 10067.949660251652, 6973.0, 7616.543007419573, 7730.884036739341, 7803.492772969966, 7896.0, 8434.704785332484, 8437.53593552336, 8492.363072769444, 8512.489250644734, 8514.872276915976, 7407.185209627044, 7576.8484630308185, 7640.083190017233, 7659.961700191463, 7708.306252437307, 7508.2867127622785, 7573.659185336784, 7600.239976002355, 7665.19515450892, 7781.572013539309, 6612.305707900794, 6643.900341494978, 6686.7993960181275, 6687.063811066358, 6690.02994565795, 4778.259369797687, 4954.1825598775795, 5006.199008158677, 5030.270610761492, 5084.313617661568, 4862.222044472867, 4986.077575648516, 5142.742862856768, 5169.560587350117, 5246.186841039645], "value": 4382.76525626053, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [273.5513757437802, 274.12690580501106, 281.16213683224, 288.7877410103575, 289.1383676643602, 5103.311053007843, 5248.239005344223, 5305.70818604977, 5327.653702509334, 5346.652467589604, 5203.635745497817, 5250.763715632796, 5259.710715910624, 5269.6574722643, 5273.314469119009, 3828.942565861514, 3926.7643941363467, 3994.900127496807, 4002.6597739192202, 4016.7389119707273, 3963.504561929759, 4004.1391100913297, 4006.298897692907, 4014.478117844676, 4019.4975628046495, 3948.506436695413, 3973.8807835764974, 3978.9005274868214, 3980.4029395590746, 3992.7005474589523, 3754.906127346811, 3991.9201615967663, 4013.418054382113, 4030.496187976503, 4032.213718324928, 3416.760826742129, 3424.280901010791, 3432.2324003138406, 3450.258194488197, 3455.8963231103107, 5107.438181799999, 5110.565601923841, 5119.948800511985, 5148.639595228336, 5198.54440756585, 4372.868813935587, 4544.954770353354, 4565.840195593139, 4567.543245675439, 4581.862544123682, 5409.2967914171295, 5409.675419474805, 5427.48438898304, 5427.891442171134, 5443.945560544384, 3794.7723136611617, 3794.9374175230705, 3800.7339486235974, 3801.8099095045413, 3819.312523745725, 5400.595845080268, 5633.647924498132, 5647.46349096831, 5676.858078548069, 5692.316921969349, 3831.0, 3834.827432765532, 3845.8653947111716, 3847.480590120354, 3850.9229815403537, 3886.5336159661024, 3886.553046399644, 3896.0, 3908.335582950905, 3931.6068393160454, 4258.297380932174, 4554.4990051094355, 4557.111363284128, 4586.197415452282, 4592.747398893026, 5142.125838607446, 5517.862053448696, 5536.501714845684, 5557.3331200256225, 5568.832935011957, 1334.2194816032536, 1334.9666258343618, 1339.4642143142821, 1350.540816122523, 1352.749741297863, 803.5299349880386, 830.2983978538126, 836.7280633794041, 846.3018010141658, 847.7541512961295, 4725.763711814396, 4784.760761961888, 4816.4220293564995, 4830.372051633265, 4833.830815921426, 4960.255961605788, 4965.90068198634, 4989.625778066659, 5127.846164615067, 5145.588352931756, 4741.35991641124, 4777.8088876445245, 4817.421909370828, 4834.758262086952, 5038.748062596929, 2990.970090299069, 3028.2738838861637, 3044.934273004431, 3052.4810782167083, 3066.1874603230162, 5853.414658534112, 5898.0, 5908.852278692981, 5926.0, 5938.960681880653, 5623.943760562342, 5804.738786754606, 5828.795992140254, 5840.094785308199, 5855.443732845373, 5773.624714393551, 5861.3552509223955, 5884.235049443545, 5890.322612899486, 5900.380460051632, 5383.461653834585, 5677.375488696158, 5692.373838877803, 5716.199732037435, 5724.542036636975, 5632.239647647515, 5643.689597072201, 5664.773409063591, 5667.773289068391, 5678.346990096192, 5602.411746766531, 5742.28221472316, 5873.676947767743, 5875.882482350415, 5883.529317654492, 3839.481669974518, 3879.670228030649, 3885.5531613863636, 3886.961130388773, 3901.785401802928, 5671.092625179951, 5721.399253078367, 5746.454086861741, 5758.452946970031, 5799.130130480462, 5292.655977361459, 5502.119660854244, 5525.640833345819, 5672.064109421899, 5679.574031947538, 5455.781768729206, 5473.17902314656, 5512.834614961557, 5578.967890940189, 5587.245721827664, 5520.420355862577, 5528.668279903219, 5531.865967476738, 5532.391436942014, 5544.7227638618715, 5451.536619387396, 5513.255710479194, 5554.722263886871, 5570.637908535932, 5586.608937374344, 5439.700816455133, 5452.945470545244, 5467.152591348347, 5481.0, 5514.09017512106], "value": 4096.702546667089, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [696.8118607975847, 738.0774032459423, 740.2745309596592, 784.2745460449084, 806.3831169155595, 15267.23663816809, 15960.32416596258, 16240.83759162408, 16581.170941452925, 16605.58486037848, 15138.318775655094, 15147.469838555653, 15290.235488225571, 15291.388344466208, 15305.693886122299, 670.0451856105055, 770.5800338815359, 784.0317208247809, 791.3787676673812, 798.7284323330067, 788.0779487999026, 788.5111231036736, 791.6121100660664, 791.6951973490219, 792.6670798264743, 829.3489610655637, 833.3208435125354, 834.470111479209, 834.8747687846841, 835.7367429259764, 686.800827759949, 694.4583225084442, 802.2058162419221, 819.1890028871434, 821.0352835418389, 599.1611743559008, 600.0848705723763, 600.1088383750127, 600.1897438458091, 600.540586451365, 15555.377784888591, 15614.063156210665, 15622.218889055503, 15622.375104995786, 15629.68740625181, 13436.664083397896, 13602.183868967795, 13757.724845503133, 13899.16605003703, 14102.435902563886, 12802.48790048397, 13021.739565208738, 13055.934720326337, 13147.342632868318, 13734.65663358414, 4486.641068714528, 4504.076664283814, 4513.959598869528, 4574.405327307462, 4741.857744267643, 65690.67154664244, 69789.0, 73374.63312683403, 73502.26497735007, 75590.62204688942, 11691.401156598704, 11740.178187526792, 11880.643580692593, 11930.88069119315, 12141.089418293663, 21596.4600884976, 21682.566348673252, 21685.457863553223, 21714.674279885814, 21722.78277217239, 8583.270422014073, 8711.303095752324, 8809.647614095493, 8848.203661670352, 8867.0, 4518.751468669189, 4664.323673067386, 4769.070031343924, 4789.185838407479, 4875.585575226075, 3686.262747450467, 3742.251549690073, 3807.447920051577, 3808.6953043756434, 3809.5619003814363, 653.4413076819251, 656.3469347998772, 669.6752075243503, 671.8857794175002, 689.5242282824835, 668.2482207516543, 691.9725205148961, 711.5303899426353, 781.0588241169377, 786.2373497707215, 9207.63169473227, 9535.141837234682, 9846.803063938682, 10103.343282686601, 10271.229657775697, 615.3846153846154, 704.8590281943632, 711.1750369571273, 729.4674887332277, 742.5433358484493, 4348.652107831366, 4704.411948506437, 4778.641601879804, 4805.399325084364, 4859.489753575895, 69821.3017869825, 74202.25797741953, 105966.0, 111623.44188279007, 111663.44168279269, 96128.51935740277, 98481.0, 99054.0, 99066.5046674762, 99144.50427747959, 75616.0, 75734.62132689302, 88450.0, 88579.55710221408, 88703.11296886948, 8366.24703776663, 8479.0, 8898.777530561529, 8924.553772311228, 8944.597493112695, 51247.48752512427, 51632.74183629208, 51836.0, 53307.73346133244, 53784.73107634437, 68594.31405686079, 74264.62867685627, 75988.0, 77914.61042694977, 78077.21922780927, 11273.436328183721, 11631.88368116342, 11633.360165190996, 11693.003832219643, 12206.938965305117, 13280.667983300495, 13306.800397994231, 13357.332133393485, 13988.440462381392, 14399.92800035993, 12367.93816030914, 12580.937095314832, 12732.172408793398, 12868.935655322039, 13145.474181032652, 12622.305773182563, 12647.557335493213, 13158.394561903257, 13173.01202409804, 13687.726245475234, 11630.127740419672, 12173.0, 12434.502619895104, 12550.43523041447, 12998.415071321624, 10473.528691208761, 10526.157907367238, 10638.202134839763, 10814.729631759268, 10982.890171098186, 10192.439415832201, 10195.337303075275, 10706.0, 10825.729356766144, 10880.891191087987], "value": 7447.840296946483, "unit": "score"}], "name": "dromaeo_css", "value": 7116.272942248353, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 111.0, 111.0, 110.0, 110.0, 113.0, 111.0, 110.0, 110.0, 109.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 125.0, 135.0, 169.0, 128.0, 128.0, 157.0, 132.0, 169.0, 124.0], "value": 141.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 171.0, 162.0, 161.0, 164.0, 163.0, 163.0, 163.0, 162.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 77.0, 131.0, 75.0, 75.0, 74.0, 75.0, 97.0, 75.0], "value": 82.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 117.0, 87.0, 86.0, 84.0, 122.0, 87.0, 86.0, 130.0], "value": 96.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 53.0, 52.0, 52.0, 53.0, 54.0, 53.0, 52.0, 53.0], "value": 52.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 62.0, 62.0, 61.0, 61.0, 61.0, 61.0, 61.0], "value": 61.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 79.0, 78.0, 78.0, 79.0, 80.0, 81.0, 148.0, 79.0], "value": 85.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 131.0, 130.0, 117.0, 132.0, 132.0, 130.0, 123.0, 133.0, 128.0], "value": 128.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 162.0, 162.0, 158.0, 161.0, 161.0, 163.0, 158.0], "value": 160.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 62.0, 62.0, 63.0, 64.0, 63.0, 61.0, 62.0, 67.0], "value": 63.0, "unit": "score"}], "name": "kraken", "value": 1505.2, "alertThreshold": 2.0}]} 02:55:08 INFO - Return code: 0 02:55:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:55:08 INFO - # TBPL SUCCESS # 02:55:08 INFO - Running post-action listener: _resource_record_post_action 02:55:08 INFO - ##### 02:55:08 INFO - ##### Finished run-tests step (success) 02:55:08 INFO - ##### 02:55:08 INFO - Running post-run listener: _resource_record_post_run 02:55:08 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 12288; Write bytes: 548941824; Read time: 208; Write time: 393604 02:55:08 INFO - TinderboxPrint: CPU usage
13.2% 02:55:08 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 208 02:55:08 INFO - TinderboxPrint: I/O write bytes / time
548,941,824 / 393,604 02:55:08 INFO - TinderboxPrint: CPU idle
8,264.1 (86.8%) 02:55:08 INFO - TinderboxPrint: CPU user
1,211.2 (12.7%) 02:55:08 INFO - TinderboxPrint: Swap in / out
0 / 0 02:55:08 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 256659456; Read time: 0; Write time: 229292 02:55:08 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 12288; Write bytes: 292282368; Read time: 208; Write time: 164312 02:55:08 INFO - Running post-run listener: _upload_blobber_files 02:55:08 INFO - Blob upload gear active. 02:55:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:55:08 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:55:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:55:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:55:09 INFO - (blobuploader) - INFO - Open directory for files ... 02:55:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:55:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:55:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:55:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:55:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:55:14 INFO - (blobuploader) - INFO - Done attempting. 02:55:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:55:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:55:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:55:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:55:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:55:14 INFO - (blobuploader) - INFO - Done attempting. 02:55:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:55:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:55:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:55:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:55:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:55:15 INFO - (blobuploader) - INFO - Done attempting. 02:55:15 INFO - (blobuploader) - INFO - Iteration through files over. 02:55:15 INFO - Return code: 0 02:55:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:55:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:55:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1a9b80d1db307dc0125e528a899b42a628d99ce180a389251ed5835ffa1fee097278dabbbca264ce6c09b8debb6cea837fafb2197137cf024f1ff88f6a5ea868", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0dcb6bc3e95e085acc2cf6bdafecdb649734e8a0e978bfb8fe0ad4cb687329573b325963a90545570b24de2aaed7788181455ca2cb2867a91247df2d7ac177bb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/15b6c7f22754002d744ecdf1eb7111151a5d8c71b13a161faa3452f743e8b2420d82b4897cdd15638176d724f425d37aac090b25d747ce4e3660fdf04279c43d"} 02:55:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:55:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:55:15 INFO - Contents: 02:55:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1a9b80d1db307dc0125e528a899b42a628d99ce180a389251ed5835ffa1fee097278dabbbca264ce6c09b8debb6cea837fafb2197137cf024f1ff88f6a5ea868", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0dcb6bc3e95e085acc2cf6bdafecdb649734e8a0e978bfb8fe0ad4cb687329573b325963a90545570b24de2aaed7788181455ca2cb2867a91247df2d7ac177bb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/15b6c7f22754002d744ecdf1eb7111151a5d8c71b13a161faa3452f743e8b2420d82b4897cdd15638176d724f425d37aac090b25d747ce4e3660fdf04279c43d"} 02:55:15 INFO - Running post-run listener: copy_logs_to_upload_dir 02:55:15 INFO - Copying logs to upload dir... 02:55:15 INFO - mkdir: /builds/slave/test/build/upload/logs 02:55:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.728294 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-06-23 02:55:12.004739) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 02:55:12.008669) ========= 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=3a3620fb28aea1604ab609ef000001d2-1466674477.101294-1412096403 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1a9b80d1db307dc0125e528a899b42a628d99ce180a389251ed5835ffa1fee097278dabbbca264ce6c09b8debb6cea837fafb2197137cf024f1ff88f6a5ea868", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0dcb6bc3e95e085acc2cf6bdafecdb649734e8a0e978bfb8fe0ad4cb687329573b325963a90545570b24de2aaed7788181455ca2cb2867a91247df2d7ac177bb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/15b6c7f22754002d744ecdf1eb7111151a5d8c71b13a161faa3452f743e8b2420d82b4897cdd15638176d724f425d37aac090b25d747ce4e3660fdf04279c43d"} 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.011234 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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1a9b80d1db307dc0125e528a899b42a628d99ce180a389251ed5835ffa1fee097278dabbbca264ce6c09b8debb6cea837fafb2197137cf024f1ff88f6a5ea868", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0dcb6bc3e95e085acc2cf6bdafecdb649734e8a0e978bfb8fe0ad4cb687329573b325963a90545570b24de2aaed7788181455ca2cb2867a91247df2d7ac177bb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/15b6c7f22754002d744ecdf1eb7111151a5d8c71b13a161faa3452f743e8b2420d82b4897cdd15638176d724f425d37aac090b25d747ce4e3660fdf04279c43d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-23 02:55:12.034725) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 02:55:12.035055) ========= 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=3a3620fb28aea1604ab609ef000001d2-1466674477.101294-1412096403 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004407 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-23 02:55:12.118048) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 02:55:12.118381) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-23 02:55:12.118693) ========= ========= Total master_lag: 0.16 =========