builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-004 starttime: 1467129098.19 results: success (0) buildid: 20160628053008 builduid: b050084aaf3843c5b304f42d5faa2bab revision: ceff61c9fc5acc0f23ac589483d09444dea69ae7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 08:51:38.195092) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 08:51:38.195584) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 08:51:38.195898) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 08:51:38.210618) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 08:51:38.210923) ========= 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=c6927cf182745ad25b1d38b9000001fe-1467129097.322592-244484951 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-28 08:51:38-- 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% 87.9M=0s 2016-06-28 08:51:38 (87.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.069537 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 08:51:38.295093) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 08:51:38.295426) ========= 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=c6927cf182745ad25b1d38b9000001fe-1467129097.322592-244484951 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016854 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 08:51:38.345234) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 08:51:38.345595) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ceff61c9fc5acc0f23ac589483d09444dea69ae7 --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 ceff61c9fc5acc0f23ac589483d09444dea69ae7 --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=c6927cf182745ad25b1d38b9000001fe-1467129097.322592-244484951 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-28 08:51:38,494 truncating revision to first 12 chars 2016-06-28 08:51:38,494 Setting DEBUG logging. 2016-06-28 08:51:38,494 attempt 1/10 2016-06-28 08:51:38,494 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ceff61c9fc5a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-28 08:51:38,881 unpacking tar archive at: fx-team-ceff61c9fc5a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.720632 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 08:51:39.080416) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 08:51:39.080747) ========= script_repo_revision: ceff61c9fc5acc0f23ac589483d09444dea69ae7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 08:51:39.081128) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 08:51:39.081455) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 08:51:39.090506) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-06-28 08:51:39.090787) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1467129097.322592-244484951 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:51:39 INFO - MultiFileLogger online at 20160628 08:51:39 in /builds/slave/test 08:51:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:51:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:51:39 INFO - {'append_to_log': False, 08:51:39 INFO - 'base_work_dir': '/builds/slave/test', 08:51:39 INFO - 'blob_upload_branch': 'Fx-Team', 08:51:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:51:39 INFO - 'branch': 'Fx-Team', 08:51:39 INFO - 'buildbot_json_path': 'buildprops.json', 08:51:39 INFO - 'config_files': ('talos/linux_config.py',), 08:51:39 INFO - 'default_actions': ('clobber', 08:51:39 INFO - 'read-buildbot-config', 08:51:39 INFO - 'download-and-extract', 08:51:39 INFO - 'populate-webroot', 08:51:39 INFO - 'create-virtualenv', 08:51:39 INFO - 'install', 08:51:39 INFO - 'run-tests'), 08:51:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:51:39 INFO - 'download_minidump_stackwalk': True, 08:51:39 INFO - 'download_symbols': 'ondemand', 08:51:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:51:39 INFO - 'tooltool.py': '/tools/tooltool.py', 08:51:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:51:39 INFO - '/tools/misc-python/virtualenv.py')}, 08:51:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:51:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:51:39 INFO - 'installer_path': 'installer.exe', 08:51:39 INFO - 'log_level': 'info', 08:51:39 INFO - 'log_name': 'talos', 08:51:39 INFO - 'log_to_console': True, 08:51:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:51:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:51:39 INFO - 'opt_config_files': (), 08:51:39 INFO - 'pip_index': False, 08:51:39 INFO - 'sps_profile': False, 08:51:39 INFO - 'sps_profile_interval': 0, 08:51:39 INFO - 'suite': 'dromaeojs-e10s', 08:51:39 INFO - 'system_bits': '32', 08:51:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:51:39 INFO - 'title': 'talos-linux64-ix-004', 08:51:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:51:39 INFO - 'use_talos_json': True, 08:51:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:51:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:51:39 INFO - 'work_dir': 'build'} 08:51:39 INFO - ##### 08:51:39 INFO - ##### Running clobber step. 08:51:39 INFO - ##### 08:51:39 INFO - Running pre-action listener: _resource_record_pre_action 08:51:39 INFO - Running main action method: clobber 08:51:39 INFO - rmtree: /builds/slave/test/build 08:51:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:51:40 INFO - Running post-action listener: _resource_record_post_action 08:51:40 INFO - ##### 08:51:40 INFO - ##### Finished clobber step (success) 08:51:40 INFO - ##### 08:51:40 INFO - ##### 08:51:40 INFO - ##### Running read-buildbot-config step. 08:51:40 INFO - ##### 08:51:40 INFO - Running pre-action listener: _resource_record_pre_action 08:51:40 INFO - Running main action method: read_buildbot_config 08:51:40 INFO - Using buildbot properties: 08:51:40 INFO - { 08:51:40 INFO - "project": "", 08:51:40 INFO - "product": "firefox", 08:51:40 INFO - "script_repo_revision": "production", 08:51:40 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 08:51:40 INFO - "repository": "", 08:51:40 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 08:51:40 INFO - "buildid": "20160628053008", 08:51:40 INFO - "pgo_build": "True", 08:51:40 INFO - "basedir": "/builds/slave/test", 08:51:40 INFO - "buildnumber": 585, 08:51:40 INFO - "slavename": "talos-linux64-ix-004", 08:51:40 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:51:40 INFO - "platform": "ubuntu64_hw", 08:51:40 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:51:40 INFO - "branch": "fx-team", 08:51:40 INFO - "repo_path": "integration/fx-team", 08:51:40 INFO - "revision": "ceff61c9fc5acc0f23ac589483d09444dea69ae7", 08:51:40 INFO - "stage_platform": "linux64-pgo", 08:51:40 INFO - "builduid": "b050084aaf3843c5b304f42d5faa2bab", 08:51:40 INFO - "slavebuilddir": "test" 08:51:40 INFO - } 08:51:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/cr5F_T4mQL6clQZeJgQLkw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:51:40 INFO - Running post-action listener: _resource_record_post_action 08:51:40 INFO - ##### 08:51:40 INFO - ##### Finished read-buildbot-config step (success) 08:51:40 INFO - ##### 08:51:40 INFO - ##### 08:51:40 INFO - ##### Running download-and-extract step. 08:51:40 INFO - ##### 08:51:40 INFO - Running pre-action listener: _resource_record_pre_action 08:51:40 INFO - Running main action method: download_and_extract 08:51:40 INFO - mkdir: /builds/slave/test/build/tests 08:51: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')]} 08:51:40 INFO - https://queue.taskcluster.net/v1/task/cr5F_T4mQL6clQZeJgQLkw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:51:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cr5F_T4mQL6clQZeJgQLkw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:51:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cr5F_T4mQL6clQZeJgQLkw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:51:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cr5F_T4mQL6clQZeJgQLkw/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 08:51:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cr5F_T4mQL6clQZeJgQLkw/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 08:51:40 INFO - Downloaded 1361 bytes. 08:51:40 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:51:40 INFO - Using the following test package requirements: 08:51:40 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:51:40 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:51:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:51:40 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:51:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:51:40 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:51:40 INFO - u'jsshell-linux-x86_64.zip'], 08:51:40 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:51:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:51:40 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:51:40 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:51:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:51:40 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:51:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:51:40 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:51:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:51:40 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:51:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:51:40 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:51: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')]} 08:51:40 INFO - https://queue.taskcluster.net/v1/task/cr5F_T4mQL6clQZeJgQLkw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:51:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cr5F_T4mQL6clQZeJgQLkw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:51:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cr5F_T4mQL6clQZeJgQLkw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:51:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cr5F_T4mQL6clQZeJgQLkw/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 08:51:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cr5F_T4mQL6clQZeJgQLkw/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 08:51:43 INFO - Downloaded 24279706 bytes. 08:51:43 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'] 08:51:43 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 08:51:45 INFO - Return code: 0 08:51:45 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 08:51: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')]} 08:51:45 INFO - https://queue.taskcluster.net/v1/task/cr5F_T4mQL6clQZeJgQLkw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:51:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cr5F_T4mQL6clQZeJgQLkw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:51:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cr5F_T4mQL6clQZeJgQLkw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:51:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cr5F_T4mQL6clQZeJgQLkw/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 08:51:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cr5F_T4mQL6clQZeJgQLkw/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 08:51:46 INFO - Downloaded 24279706 bytes. 08:51:46 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'] 08:51:46 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 08:51:47 INFO - Return code: 0 08:51: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')]} 08:51:47 INFO - https://queue.taskcluster.net/v1/task/cr5F_T4mQL6clQZeJgQLkw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:51:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cr5F_T4mQL6clQZeJgQLkw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:51:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cr5F_T4mQL6clQZeJgQLkw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:51:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cr5F_T4mQL6clQZeJgQLkw/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 08:51:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cr5F_T4mQL6clQZeJgQLkw/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 08:51:48 INFO - Downloaded 14405245 bytes. 08:51:48 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'] 08:51:48 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 08:51:48 INFO - Return code: 0 08:51:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:51:48 INFO - https://queue.taskcluster.net/v1/task/cr5F_T4mQL6clQZeJgQLkw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:51:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cr5F_T4mQL6clQZeJgQLkw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:51:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cr5F_T4mQL6clQZeJgQLkw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:51:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cr5F_T4mQL6clQZeJgQLkw/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 08:51:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cr5F_T4mQL6clQZeJgQLkw/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 08:51:52 INFO - Downloaded 60311862 bytes. 08:51:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cr5F_T4mQL6clQZeJgQLkw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:51:52 INFO - mkdir: /builds/slave/test/properties 08:51:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:51:52 INFO - Writing to file /builds/slave/test/properties/build_url 08:51:52 INFO - Contents: 08:51:52 INFO - build_url:https://queue.taskcluster.net/v1/task/cr5F_T4mQL6clQZeJgQLkw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:51:53 INFO - Running post-action listener: _resource_record_post_action 08:51:53 INFO - Running post-action listener: set_extra_try_arguments 08:51:53 INFO - ##### 08:51:53 INFO - ##### Finished download-and-extract step (success) 08:51:53 INFO - ##### 08:51:53 INFO - ##### 08:51:53 INFO - ##### Running populate-webroot step. 08:51:53 INFO - ##### 08:51:53 INFO - Running pre-action listener: _resource_record_pre_action 08:51:53 INFO - Running main action method: populate_webroot 08:51:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:51:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:51:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:51:53 INFO - '--tppagecycles', 08:51:53 INFO - '7'], 08:51:53 INFO - 'tests': ['tsvgm']}}, 08:51:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:51:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:51:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:51:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:51:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:51:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:51:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:53 INFO - 'talos_options': ['--disable-e10s'], 08:51:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:51:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:51:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:53 INFO - 'talos_options': ['--disable-e10s'], 08:51:53 INFO - 'tests': ['damp', 'tps']}, 08:51:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:53 INFO - 'tests': ['damp', 'tps']}, 08:51:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:51:53 INFO - 'tests': ['dromaeo_dom']}, 08:51:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:51:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:51:53 INFO - 'tests': ['basic_compositor_video']}, 08:51:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:51:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:51:53 INFO - 'tests': ['a11yr', 08:51:53 INFO - 'ts_paint', 08:51:53 INFO - 'tpaint', 08:51:53 INFO - 'sessionrestore', 08:51:53 INFO - 'sessionrestore_no_auto_restore', 08:51:53 INFO - 'tabpaint']}, 08:51:53 INFO - 'other-e10s': {'tests': ['a11yr', 08:51:53 INFO - 'ts_paint', 08:51:53 INFO - 'tpaint', 08:51:53 INFO - 'sessionrestore', 08:51:53 INFO - 'sessionrestore_no_auto_restore', 08:51:53 INFO - 'tabpaint']}, 08:51:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:51:53 INFO - 'ts_paint', 08:51:53 INFO - 'tpaint', 08:51:53 INFO - 'sessionrestore', 08:51:53 INFO - 'sessionrestore_no_auto_restore', 08:51:53 INFO - 'tabpaint']}, 08:51:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:51:53 INFO - 'ts_paint', 08:51:53 INFO - 'tpaint', 08:51:53 INFO - 'sessionrestore', 08:51:53 INFO - 'sessionrestore_no_auto_restore', 08:51:53 INFO - 'tabpaint']}, 08:51:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:51:53 INFO - 'tests': ['a11yr', 08:51:53 INFO - 'ts_paint', 08:51:53 INFO - 'tpaint', 08:51:53 INFO - 'sessionrestore', 08:51:53 INFO - 'sessionrestore_no_auto_restore', 08:51:53 INFO - 'tabpaint']}, 08:51:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:51:53 INFO - 'tests': ['a11yr', 08:51:53 INFO - 'ts_paint', 08:51:53 INFO - 'tpaint', 08:51:53 INFO - 'sessionrestore', 08:51:53 INFO - 'sessionrestore_no_auto_restore', 08:51:53 INFO - 'tabpaint']}, 08:51:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:51:53 INFO - 'tests': ['tsvgx', 08:51:53 INFO - 'tsvgr_opacity', 08:51:53 INFO - 'tart', 08:51:53 INFO - 'tscrollx', 08:51:53 INFO - 'cart']}, 08:51:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:51:53 INFO - 'tsvgr_opacity', 08:51:53 INFO - 'tart', 08:51:53 INFO - 'tscrollx', 08:51:53 INFO - 'cart']}, 08:51:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:53 INFO - 'talos_options': ['--disable-e10s'], 08:51:53 INFO - 'tests': ['tp5o']}, 08:51:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:53 INFO - 'tests': ['tp5o']}, 08:51:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:53 INFO - 'talos_options': ['--disable-e10s', 08:51:53 INFO - '--xperf_path', 08:51:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:51:53 INFO - 'tests': ['tp5n']}, 08:51:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:51:53 INFO - 'talos_options': ['--xperf_path', 08:51:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:51:53 INFO - 'tests': ['tp5n']}}, 08:51:53 INFO - 'talos.zip': {'path': '', 08:51:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:51:53 INFO - Running post-action listener: _resource_record_post_action 08:51:53 INFO - ##### 08:51:53 INFO - ##### Finished populate-webroot step (success) 08:51:53 INFO - ##### 08:51:53 INFO - ##### 08:51:53 INFO - ##### Running create-virtualenv step. 08:51:53 INFO - ##### 08:51:53 INFO - Running pre-action listener: _resource_record_pre_action 08:51:53 INFO - Running main action method: create_virtualenv 08:51:53 INFO - Creating virtualenv /builds/slave/test/build/venv 08:51:53 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 08:51:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:51:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:51:53 INFO - Using real prefix '/usr' 08:51:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:51:53 INFO - Installing distribute.............................................................................................................................................................................................done. 08:51:55 INFO - Installing pip.................done. 08:51:55 INFO - Return code: 0 08:51:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:51: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')]} 08:51:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51: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')]} 08:51:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6dcc3e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1108590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1197570>, '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 0x1198470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1198920>, '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': 'c6927cf182745ad25b1d38b9000001fe-1467129097.322592-244484951', '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 08:51: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', 'pip>=1.5'] in /builds/slave/test/build 08:51: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 pip>=1.5 08:51:55 INFO - Using env: {'DISPLAY': ':0', 08:51:55 INFO - 'HOME': '/home/cltbld', 08:51:55 INFO - 'LANG': 'en_US.UTF-8', 08:51:55 INFO - 'LANGUAGE': 'en_US:en', 08:51:55 INFO - 'LOGNAME': 'cltbld', 08:51:55 INFO - 'MAIL': '/var/mail/cltbld', 08:51:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:55 INFO - 'MOZ_NO_REMOTE': '1', 08:51:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:51:55 INFO - 'NO_EM_RESTART': '1', 08:51:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:51:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:55 INFO - 'PWD': '/builds/slave/test', 08:51:55 INFO - 'SHELL': '/bin/bash', 08:51:55 INFO - 'SHLVL': '1', 08:51:55 INFO - 'TERM': 'linux', 08:51:55 INFO - 'TMOUT': '86400', 08:51:55 INFO - 'USER': 'cltbld', 08:51:55 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467129097.322592-244484951', 08:51:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:55 INFO - '_': '/tools/buildbot/bin/python'} 08:51:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:55 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 08:51:55 INFO - Cleaning up... 08:51:55 INFO - Return code: 0 08:51:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:51: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')]} 08:51:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51: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')]} 08:51:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51: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', '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 0x7f6dcc3e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1108590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1197570>, '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 0x1198470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1198920>, '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': 'c6927cf182745ad25b1d38b9000001fe-1467129097.322592-244484951', '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 08:51: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', 'psutil>=3.1.1'] in /builds/slave/test/build 08:51: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 psutil>=3.1.1 08:51:55 INFO - Using env: {'DISPLAY': ':0', 08:51:55 INFO - 'HOME': '/home/cltbld', 08:51:55 INFO - 'LANG': 'en_US.UTF-8', 08:51:55 INFO - 'LANGUAGE': 'en_US:en', 08:51:55 INFO - 'LOGNAME': 'cltbld', 08:51:55 INFO - 'MAIL': '/var/mail/cltbld', 08:51:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:55 INFO - 'MOZ_NO_REMOTE': '1', 08:51:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:51:55 INFO - 'NO_EM_RESTART': '1', 08:51:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:51:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:55 INFO - 'PWD': '/builds/slave/test', 08:51:55 INFO - 'SHELL': '/bin/bash', 08:51:55 INFO - 'SHLVL': '1', 08:51:55 INFO - 'TERM': 'linux', 08:51:55 INFO - 'TMOUT': '86400', 08:51:55 INFO - 'USER': 'cltbld', 08:51:55 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467129097.322592-244484951', 08:51:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:55 INFO - '_': '/tools/buildbot/bin/python'} 08:51:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:56 INFO - Downloading/unpacking psutil>=3.1.1 08:51:56 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 08:51:56 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 08:51:56 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 08:51:56 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 08:51:56 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 08:51:56 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 08:51:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:51:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:51:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:51:58 INFO - Installing collected packages: psutil 08:51:58 INFO - Running setup.py install for psutil 08:51:58 INFO - building 'psutil._psutil_linux' extension 08:51:58 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 08:51:58 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 08:51:58 INFO - building 'psutil._psutil_posix' extension 08:51:58 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 08:51:58 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 08:51:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:51:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:51:58 INFO - Successfully installed psutil 08:51:58 INFO - Cleaning up... 08:51:58 INFO - Return code: 0 08:51:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:51:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:51:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:51:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:58 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 0x7f6dcc3e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1108590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1197570>, '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 0x1198470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1198920>, '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': 'c6927cf182745ad25b1d38b9000001fe-1467129097.322592-244484951', '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 08:51:58 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 08:51:58 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 08:51:58 INFO - Using env: {'DISPLAY': ':0', 08:51:58 INFO - 'HOME': '/home/cltbld', 08:51:58 INFO - 'LANG': 'en_US.UTF-8', 08:51:58 INFO - 'LANGUAGE': 'en_US:en', 08:51:58 INFO - 'LOGNAME': 'cltbld', 08:51:58 INFO - 'MAIL': '/var/mail/cltbld', 08:51:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:58 INFO - 'MOZ_NO_REMOTE': '1', 08:51:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:51:58 INFO - 'NO_EM_RESTART': '1', 08:51:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:51:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:58 INFO - 'PWD': '/builds/slave/test', 08:51:58 INFO - 'SHELL': '/bin/bash', 08:51:58 INFO - 'SHLVL': '1', 08:51:58 INFO - 'TERM': 'linux', 08:51:58 INFO - 'TMOUT': '86400', 08:51:58 INFO - 'USER': 'cltbld', 08:51:58 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467129097.322592-244484951', 08:51:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:58 INFO - '_': '/tools/buildbot/bin/python'} 08:51:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:51: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 08:51: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 08:51: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 08:51: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 08:51: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 08:51: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 08:52:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:52:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:52:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:52:00 INFO - Installing collected packages: mozsystemmonitor 08:52:00 INFO - Running setup.py install for mozsystemmonitor 08:52:01 INFO - Successfully installed mozsystemmonitor 08:52:01 INFO - Cleaning up... 08:52:01 INFO - Return code: 0 08:52:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:52:01 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')]} 08:52:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:01 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')]} 08:52:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:01 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 0x7f6dcc3e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1108590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1197570>, '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 0x1198470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1198920>, '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': 'c6927cf182745ad25b1d38b9000001fe-1467129097.322592-244484951', '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 08:52:01 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 08:52:01 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 08:52:01 INFO - Using env: {'DISPLAY': ':0', 08:52:01 INFO - 'HOME': '/home/cltbld', 08:52:01 INFO - 'LANG': 'en_US.UTF-8', 08:52:01 INFO - 'LANGUAGE': 'en_US:en', 08:52:01 INFO - 'LOGNAME': 'cltbld', 08:52:01 INFO - 'MAIL': '/var/mail/cltbld', 08:52:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:01 INFO - 'MOZ_NO_REMOTE': '1', 08:52:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:01 INFO - 'NO_EM_RESTART': '1', 08:52:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:01 INFO - 'PWD': '/builds/slave/test', 08:52:01 INFO - 'SHELL': '/bin/bash', 08:52:01 INFO - 'SHLVL': '1', 08:52:01 INFO - 'TERM': 'linux', 08:52:01 INFO - 'TMOUT': '86400', 08:52:01 INFO - 'USER': 'cltbld', 08:52:01 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467129097.322592-244484951', 08:52:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:01 INFO - '_': '/tools/buildbot/bin/python'} 08:52:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:01 INFO - Downloading/unpacking jsonschema==2.5.1 08:52:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:52:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:52:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:03 INFO - Downloading functools32-3.2.3-2.tar.gz 08:52:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:52:03 INFO - warning: no files found matching '*.txt' 08:52:03 INFO - no previously-included directories found matching 'build' 08:52:03 INFO - no previously-included directories found matching 'dist' 08:52:03 INFO - no previously-included directories found matching '.git*' 08:52:03 INFO - Installing collected packages: jsonschema, functools32 08:52:03 INFO - Running setup.py install for functools32 08:52:03 INFO - warning: no files found matching '*.txt' 08:52:03 INFO - no previously-included directories found matching 'build' 08:52:03 INFO - no previously-included directories found matching 'dist' 08:52:03 INFO - no previously-included directories found matching '.git*' 08:52:03 INFO - Successfully installed jsonschema functools32 08:52:03 INFO - Cleaning up... 08:52:03 INFO - Return code: 0 08:52:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:52: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')]} 08:52:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52: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')]} 08:52:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6dcc3e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1108590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1197570>, '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 0x1198470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1198920>, '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': 'c6927cf182745ad25b1d38b9000001fe-1467129097.322592-244484951', '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 08:52:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:52:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:52:03 INFO - Using env: {'DISPLAY': ':0', 08:52:03 INFO - 'HOME': '/home/cltbld', 08:52:03 INFO - 'LANG': 'en_US.UTF-8', 08:52:03 INFO - 'LANGUAGE': 'en_US:en', 08:52:03 INFO - 'LOGNAME': 'cltbld', 08:52:03 INFO - 'MAIL': '/var/mail/cltbld', 08:52:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:03 INFO - 'MOZ_NO_REMOTE': '1', 08:52:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:03 INFO - 'NO_EM_RESTART': '1', 08:52:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:03 INFO - 'PWD': '/builds/slave/test', 08:52:03 INFO - 'SHELL': '/bin/bash', 08:52:03 INFO - 'SHLVL': '1', 08:52:03 INFO - 'TERM': 'linux', 08:52:03 INFO - 'TMOUT': '86400', 08:52:03 INFO - 'USER': 'cltbld', 08:52:03 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467129097.322592-244484951', 08:52:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:03 INFO - '_': '/tools/buildbot/bin/python'} 08:52:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:03 INFO - Downloading/unpacking blobuploader==1.2.4 08:52:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:05 INFO - Downloading blobuploader-1.2.4.tar.gz 08:52:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:52:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:52:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:06 INFO - Downloading docopt-0.6.1.tar.gz 08:52:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:52:06 INFO - Installing collected packages: blobuploader, requests, docopt 08:52:06 INFO - Running setup.py install for blobuploader 08:52:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:52:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:52:06 INFO - Running setup.py install for requests 08:52:07 INFO - Running setup.py install for docopt 08:52:07 INFO - Successfully installed blobuploader requests docopt 08:52:07 INFO - Cleaning up... 08:52:07 INFO - Return code: 0 08:52:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:52: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')]} 08:52:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52: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')]} 08:52:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:07 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 0x7f6dcc3e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1108590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1197570>, '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 0x1198470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1198920>, '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': 'c6927cf182745ad25b1d38b9000001fe-1467129097.322592-244484951', '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 08:52:07 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 08:52:07 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 08:52:07 INFO - Using env: {'DISPLAY': ':0', 08:52:07 INFO - 'HOME': '/home/cltbld', 08:52:07 INFO - 'LANG': 'en_US.UTF-8', 08:52:07 INFO - 'LANGUAGE': 'en_US:en', 08:52:07 INFO - 'LOGNAME': 'cltbld', 08:52:07 INFO - 'MAIL': '/var/mail/cltbld', 08:52:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:07 INFO - 'MOZ_NO_REMOTE': '1', 08:52:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:07 INFO - 'NO_EM_RESTART': '1', 08:52:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:07 INFO - 'PWD': '/builds/slave/test', 08:52:07 INFO - 'SHELL': '/bin/bash', 08:52:07 INFO - 'SHLVL': '1', 08:52:07 INFO - 'TERM': 'linux', 08:52:07 INFO - 'TMOUT': '86400', 08:52:07 INFO - 'USER': 'cltbld', 08:52:07 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467129097.322592-244484951', 08:52:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:07 INFO - '_': '/tools/buildbot/bin/python'} 08:52:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:52:07 INFO - Running setup.py (path:/tmp/pip-4hsV76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:52:07 INFO - Running setup.py (path:/tmp/pip-rN5P4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:52:07 INFO - Running setup.py (path:/tmp/pip-xkIVcX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:52:07 INFO - Running setup.py (path:/tmp/pip-rSRR5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:52:07 INFO - Running setup.py (path:/tmp/pip-u3Uhxb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:52:07 INFO - Running setup.py (path:/tmp/pip-p8eXV4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:52:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:52:07 INFO - Running setup.py (path:/tmp/pip-FTna3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:52:08 INFO - Running setup.py (path:/tmp/pip-OLq5l7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:52:08 INFO - Running setup.py (path:/tmp/pip-3mbGFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:52:08 INFO - Running setup.py (path:/tmp/pip-4b7_B_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:52:08 INFO - Running setup.py (path:/tmp/pip-QTdvNa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:52:08 INFO - Running setup.py (path:/tmp/pip-nGRuSj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:52:08 INFO - Running setup.py (path:/tmp/pip-h3fZXj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:52:08 INFO - Running setup.py (path:/tmp/pip-lV0IMJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:52:08 INFO - Running setup.py (path:/tmp/pip-PL7zmr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:52:08 INFO - Running setup.py (path:/tmp/pip-yYPc48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:52:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:52:08 INFO - Running setup.py (path:/tmp/pip-XdqzH7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:52:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:52:08 INFO - Running setup.py install for manifestparser 08:52:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:52:08 INFO - Running setup.py install for mozcrash 08:52:08 INFO - Running setup.py install for mozdebug 08:52:09 INFO - Running setup.py install for mozdevice 08:52:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:52:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:52:09 INFO - Running setup.py install for mozfile 08:52:09 INFO - Running setup.py install for mozhttpd 08:52:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:52:09 INFO - Running setup.py install for mozinfo 08:52:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:52:09 INFO - Running setup.py install for mozInstall 08:52:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:52:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:52:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:52:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:52:09 INFO - Running setup.py install for mozleak 08:52:09 INFO - Running setup.py install for mozlog 08:52:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:52:09 INFO - Running setup.py install for moznetwork 08:52:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:52:09 INFO - Running setup.py install for mozprocess 08:52:09 INFO - Running setup.py install for mozprofile 08:52:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:52:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:52:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:52:10 INFO - Running setup.py install for mozrunner 08:52:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:52:10 INFO - Running setup.py install for mozscreenshot 08:52:10 INFO - Running setup.py install for moztest 08:52:10 INFO - Running setup.py install for mozversion 08:52:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:52:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:52:10 INFO - Cleaning up... 08:52:10 INFO - Return code: 0 08:52:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:52: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')]} 08:52:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52: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')]} 08:52:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:10 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 0x7f6dcc3e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1108590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1197570>, '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 0x1198470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1198920>, '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': 'c6927cf182745ad25b1d38b9000001fe-1467129097.322592-244484951', '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 08:52:10 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 08:52:10 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 08:52:10 INFO - Using env: {'DISPLAY': ':0', 08:52:10 INFO - 'HOME': '/home/cltbld', 08:52:10 INFO - 'LANG': 'en_US.UTF-8', 08:52:10 INFO - 'LANGUAGE': 'en_US:en', 08:52:10 INFO - 'LOGNAME': 'cltbld', 08:52:10 INFO - 'MAIL': '/var/mail/cltbld', 08:52:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:10 INFO - 'MOZ_NO_REMOTE': '1', 08:52:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:10 INFO - 'NO_EM_RESTART': '1', 08:52:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:10 INFO - 'PWD': '/builds/slave/test', 08:52:10 INFO - 'SHELL': '/bin/bash', 08:52:10 INFO - 'SHLVL': '1', 08:52:10 INFO - 'TERM': 'linux', 08:52:10 INFO - 'TMOUT': '86400', 08:52:10 INFO - 'USER': 'cltbld', 08:52:10 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467129097.322592-244484951', 08:52:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:10 INFO - '_': '/tools/buildbot/bin/python'} 08:52:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:52:10 INFO - Running setup.py (path:/tmp/pip-L0_7mH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:52:10 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)) 08:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:52:10 INFO - Running setup.py (path:/tmp/pip-LUjUMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:52:10 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)) 08:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:52:10 INFO - Running setup.py (path:/tmp/pip-1S4Xq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:52:10 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)) 08:52:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:52:10 INFO - Running setup.py (path:/tmp/pip-7t1x2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:52:11 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)) 08:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:52:11 INFO - Running setup.py (path:/tmp/pip-X3Lr7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:52:11 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)) 08:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:52:11 INFO - Running setup.py (path:/tmp/pip-CdkYmH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:52:11 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)) 08:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:52:11 INFO - Running setup.py (path:/tmp/pip-iXC0zC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:52:11 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)) 08:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:52:11 INFO - Running setup.py (path:/tmp/pip-6AjywL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:52:11 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)) 08:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:52:11 INFO - Running setup.py (path:/tmp/pip-c78w1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:52:11 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)) 08:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:52:11 INFO - Running setup.py (path:/tmp/pip-ez9IEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:52:11 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)) 08:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:52:11 INFO - Running setup.py (path:/tmp/pip-uGQo4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:52:11 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)) 08:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:52:11 INFO - Running setup.py (path:/tmp/pip-rQMQN5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:52:11 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)) 08:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:52:11 INFO - Running setup.py (path:/tmp/pip-AJ7KNe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:52:11 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)) 08:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:52:11 INFO - Running setup.py (path:/tmp/pip-LyFdzG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:52:11 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)) 08:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:52:11 INFO - Running setup.py (path:/tmp/pip-kjrCfG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:52:11 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)) 08:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:52:11 INFO - Running setup.py (path:/tmp/pip-4WGj8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:52:11 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)) 08:52:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:52:11 INFO - Running setup.py (path:/tmp/pip-Z1P0PE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:52:11 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)) 08:52:11 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)) 08:52:11 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)) 08:52:11 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)) 08:52:11 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)) 08:52:11 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)) 08:52:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:52:12 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 08:52:12 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 08:52:12 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 08:52:12 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 08:52:12 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 08:52:12 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 08:52:13 INFO - Downloading blessings-1.6.tar.gz 08:52:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:52:13 INFO - Installing collected packages: blessings 08:52:13 INFO - Running setup.py install for blessings 08:52:14 INFO - Successfully installed blessings 08:52:14 INFO - Cleaning up... 08:52:14 INFO - Return code: 0 08:52:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:52:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:52:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:52:14 INFO - Reading from file tmpfile_stdout 08:52:14 INFO - Current package versions: 08:52:14 INFO - argparse == 1.2.1 08:52:14 INFO - blessings == 1.6 08:52:14 INFO - blobuploader == 1.2.4 08:52:14 INFO - docopt == 0.6.1 08:52:14 INFO - functools32 == 3.2.3-2 08:52:14 INFO - jsonschema == 2.5.1 08:52:14 INFO - manifestparser == 1.1 08:52:14 INFO - mozInstall == 1.12 08:52:14 INFO - mozcrash == 0.17 08:52:14 INFO - mozdebug == 0.1 08:52:14 INFO - mozdevice == 0.48 08:52:14 INFO - mozfile == 1.2 08:52:14 INFO - mozhttpd == 0.7 08:52:14 INFO - mozinfo == 0.9 08:52:14 INFO - mozleak == 0.1 08:52:14 INFO - mozlog == 3.2 08:52:14 INFO - moznetwork == 0.27 08:52:14 INFO - mozprocess == 0.22 08:52:14 INFO - mozprofile == 0.28 08:52:14 INFO - mozrunner == 6.11 08:52:14 INFO - mozscreenshot == 0.1 08:52:14 INFO - mozsystemmonitor == 0.3 08:52:14 INFO - moztest == 0.7 08:52:14 INFO - mozversion == 1.4 08:52:14 INFO - psutil == 3.1.1 08:52:14 INFO - requests == 1.2.3 08:52:14 INFO - wsgiref == 0.1.2 08:52:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:52:14 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')]} 08:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:14 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')]} 08:52:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:14 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 0x7f6dcc3e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1108590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1197570>, '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 0x1198470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1198920>, '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': 'c6927cf182745ad25b1d38b9000001fe-1467129097.322592-244484951', '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 08:52:14 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 08:52:14 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 08:52:14 INFO - Using env: {'DISPLAY': ':0', 08:52:14 INFO - 'HOME': '/home/cltbld', 08:52:14 INFO - 'LANG': 'en_US.UTF-8', 08:52:14 INFO - 'LANGUAGE': 'en_US:en', 08:52:14 INFO - 'LOGNAME': 'cltbld', 08:52:14 INFO - 'MAIL': '/var/mail/cltbld', 08:52:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:14 INFO - 'MOZ_NO_REMOTE': '1', 08:52:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:14 INFO - 'NO_EM_RESTART': '1', 08:52:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:14 INFO - 'PWD': '/builds/slave/test', 08:52:14 INFO - 'SHELL': '/bin/bash', 08:52:14 INFO - 'SHLVL': '1', 08:52:14 INFO - 'TERM': 'linux', 08:52:14 INFO - 'TMOUT': '86400', 08:52:14 INFO - 'USER': 'cltbld', 08:52:14 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467129097.322592-244484951', 08:52:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:14 INFO - '_': '/tools/buildbot/bin/python'} 08:52:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:14 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)) 08:52:14 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)) 08:52:14 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)) 08:52:14 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)) 08:52:14 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)) 08:52:14 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)) 08:52:14 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)) 08:52:14 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)) 08:52:14 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)) 08:52:14 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)) 08:52:14 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)) 08:52:14 INFO - Cleaning up... 08:52:14 INFO - Return code: 0 08:52:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:52:14 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')]} 08:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:14 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')]} 08:52:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:14 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 0x7f6dcc3e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1108590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1197570>, '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 0x1198470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1198920>, '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': 'c6927cf182745ad25b1d38b9000001fe-1467129097.322592-244484951', '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 08:52:14 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 08:52:14 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 08:52:14 INFO - Using env: {'DISPLAY': ':0', 08:52:14 INFO - 'HOME': '/home/cltbld', 08:52:14 INFO - 'LANG': 'en_US.UTF-8', 08:52:14 INFO - 'LANGUAGE': 'en_US:en', 08:52:14 INFO - 'LOGNAME': 'cltbld', 08:52:14 INFO - 'MAIL': '/var/mail/cltbld', 08:52:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:14 INFO - 'MOZ_NO_REMOTE': '1', 08:52:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:14 INFO - 'NO_EM_RESTART': '1', 08:52:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:14 INFO - 'PWD': '/builds/slave/test', 08:52:14 INFO - 'SHELL': '/bin/bash', 08:52:14 INFO - 'SHLVL': '1', 08:52:14 INFO - 'TERM': 'linux', 08:52:14 INFO - 'TMOUT': '86400', 08:52:14 INFO - 'USER': 'cltbld', 08:52:14 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467129097.322592-244484951', 08:52:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:14 INFO - '_': '/tools/buildbot/bin/python'} 08:52:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:52:14 INFO - Cleaning up... 08:52:14 INFO - Return code: 0 08:52:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:52:14 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')]} 08:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:14 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')]} 08:52:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:14 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 0x7f6dcc3e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1108590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1197570>, '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 0x1198470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1198920>, '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': 'c6927cf182745ad25b1d38b9000001fe-1467129097.322592-244484951', '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 08:52:14 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 08:52:14 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 08:52:14 INFO - Using env: {'DISPLAY': ':0', 08:52:14 INFO - 'HOME': '/home/cltbld', 08:52:14 INFO - 'LANG': 'en_US.UTF-8', 08:52:14 INFO - 'LANGUAGE': 'en_US:en', 08:52:14 INFO - 'LOGNAME': 'cltbld', 08:52:14 INFO - 'MAIL': '/var/mail/cltbld', 08:52:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:14 INFO - 'MOZ_NO_REMOTE': '1', 08:52:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:14 INFO - 'NO_EM_RESTART': '1', 08:52:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:14 INFO - 'PWD': '/builds/slave/test', 08:52:14 INFO - 'SHELL': '/bin/bash', 08:52:14 INFO - 'SHLVL': '1', 08:52:14 INFO - 'TERM': 'linux', 08:52:14 INFO - 'TMOUT': '86400', 08:52:14 INFO - 'USER': 'cltbld', 08:52:14 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467129097.322592-244484951', 08:52:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:14 INFO - '_': '/tools/buildbot/bin/python'} 08:52:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:15 INFO - Downloading/unpacking flake8 08:52:15 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 08:52:15 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 08:52:15 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 08:52:15 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 08:52:15 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 08:52:15 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 08:52:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:52:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:52:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:52:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:52:17 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 08:52:17 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 08:52:17 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 08:52:17 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 08:52:17 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 08:52:17 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 08:52:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:52:17 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 08:52:17 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 08:52:17 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 08:52:17 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 08:52:17 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 08:52:17 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 08:52:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:52:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:52:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:52:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:52:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:52:17 INFO - no previously-included directories found matching 'docs/_build' 08:52:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:52:17 INFO - Running setup.py install for pep8 08:52:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:52:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:52:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:52:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:52:17 INFO - no previously-included directories found matching 'docs/_build' 08:52:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:52:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:52:17 INFO - Cleaning up... 08:52:17 INFO - Return code: 0 08:52:17 INFO - Running post-action listener: _resource_record_post_action 08:52:17 INFO - Running post-action listener: _start_resource_monitoring 08:52:17 INFO - Starting resource monitoring. 08:52:17 INFO - ##### 08:52:17 INFO - ##### Finished create-virtualenv step (success) 08:52:17 INFO - ##### 08:52:17 INFO - ##### 08:52:17 INFO - ##### Running install step. 08:52:17 INFO - ##### 08:52:17 INFO - Running pre-action listener: _resource_record_pre_action 08:52:17 INFO - Running main action method: install 08:52:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:52:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:52:18 INFO - Reading from file tmpfile_stdout 08:52:18 INFO - Detecting whether we're running mozinstall >=1.0... 08:52:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:52:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:52:18 INFO - Reading from file tmpfile_stdout 08:52:18 INFO - Output received: 08:52:18 INFO - Usage: mozinstall [options] installer 08:52:18 INFO - Options: 08:52:18 INFO - -h, --help show this help message and exit 08:52:18 INFO - -d DEST, --destination=DEST 08:52:18 INFO - Directory to install application into. [default: 08:52:18 INFO - "/builds/slave/test"] 08:52:18 INFO - --app=APP Application being installed. [default: firefox] 08:52:18 INFO - mkdir: /builds/slave/test/build/application 08:52:18 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'] 08:52:18 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 08:52:35 INFO - Reading from file tmpfile_stdout 08:52:35 INFO - Output received: 08:52:35 INFO - /builds/slave/test/build/application/firefox/firefox 08:52:35 INFO - Running post-action listener: _resource_record_post_action 08:52:35 INFO - ##### 08:52:35 INFO - ##### Finished install step (success) 08:52:35 INFO - ##### 08:52:35 INFO - ##### 08:52:35 INFO - ##### Running run-tests step. 08:52:35 INFO - ##### 08:52:35 INFO - Running pre-action listener: _resource_record_pre_action 08:52:35 INFO - Running main action method: run_tests 08:52:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:52:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:52:35 INFO - Python 2.7.3 08:52:35 INFO - Return code: 0 08:52:35 INFO - grabbing minidump binary from tooltool 08:52:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:52:35 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 0x1197570>, '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 0x1198470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1198920>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:52:35 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 08:52:35 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 08:52:35 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 08:52:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:52:35 INFO - Return code: 0 08:52:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:52:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:52:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:52:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:52:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:52:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:52:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:52:36 INFO - Return code: 0 08:52:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cr5F_T4mQL6clQZeJgQLkw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:52:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cr5F_T4mQL6clQZeJgQLkw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:52:36 INFO - Using env: {'DISPLAY': ':0', 08:52:36 INFO - 'HOME': '/home/cltbld', 08:52:36 INFO - 'LANG': 'en_US.UTF-8', 08:52:36 INFO - 'LANGUAGE': 'en_US:en', 08:52:36 INFO - 'LOGNAME': 'cltbld', 08:52:36 INFO - 'MAIL': '/var/mail/cltbld', 08:52:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:52:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:52:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:36 INFO - 'MOZ_NO_REMOTE': '1', 08:52:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:52:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:36 INFO - 'NO_EM_RESTART': '1', 08:52:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:36 INFO - 'PWD': '/builds/slave/test', 08:52:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:52:36 INFO - 'SHELL': '/bin/bash', 08:52:36 INFO - 'SHLVL': '1', 08:52:36 INFO - 'TERM': 'linux', 08:52:36 INFO - 'TMOUT': '86400', 08:52:36 INFO - 'USER': 'cltbld', 08:52:36 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1467129097.322592-244484951', 08:52:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:36 INFO - '_': '/tools/buildbot/bin/python'} 08:52:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cr5F_T4mQL6clQZeJgQLkw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:52:36 INFO - mozversion application_buildid: 20160628053008 08:52:36 INFO - mozversion application_changeset: ceff61c9fc5acc0f23ac589483d09444dea69ae7 08:52:36 INFO - mozversion application_display_name: Nightly 08:52:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:52:36 INFO - mozversion application_name: Firefox 08:52:36 INFO - mozversion application_remotingname: firefox 08:52:36 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:52:36 INFO - mozversion application_vendor: Mozilla 08:52:36 INFO - mozversion application_version: 50.0a1 08:52:36 INFO - mozversion platform_buildid: 20160628053008 08:52:36 INFO - mozversion platform_changeset: ceff61c9fc5acc0f23ac589483d09444dea69ae7 08:52:36 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:52:36 INFO - mozversion platform_version: 50.0a1 08:52:36 INFO - using testdate: 1467129156 08:52:36 INFO - actual date: 1467129156 08:52:36 INFO - starting webserver on 'localhost:32793' 08:52:36 INFO - SUITE-START | Running 2 tests 08:52:36 INFO - TEST-START | dromaeo_css 08:52:36 INFO - operating with platform_type : linux_ 08:52:36 INFO - Initialising browser for dromaeo_css test... 08:52:36 INFO - TEST-INFO | started process 4728 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvPwStn/profile http://localhost:32793/getInfo.html) 08:52:41 INFO - PROCESS | 4728 | __metrics Screen width/height:1600/1200 08:52:41 INFO - PROCESS | 4728 | colorDepth:24 08:52:41 INFO - PROCESS | 4728 | Browser inner width/height: 1024/697 08:52:41 INFO - PROCESS | 4728 | __metrics 08:52:41 ERROR - PROCESS | 4728 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 08:52:42 INFO - TEST-INFO | 4728: exit 0 08:52:42 INFO - Browser initialized. 08:52:42 INFO - Running cycle 1/1 for dromaeo_css test... 08:52:42 INFO - TEST-INFO | started process 4847 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvPwStn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:52:54 INFO - PROCESS | 4847 | RSS: Main: 184852480 08:52:54 INFO - PROCESS | 4847 | 08:53:44 INFO - PROCESS | 4847 | 1467129224397 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] 08:55:52 INFO - PROCESS | 4847 | Cycle 1(1): loaded http://localhost:32793/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32793/tests/dromaeo/cssquery-ext.html) 08:55:53 INFO - PROCESS | 4847 | RSS: Main: 188997632 08:55:53 INFO - PROCESS | 4847 | 08:58:55 INFO - PROCESS | 4847 | Cycle 1(1): loaded http://localhost:32793/tests/dromaeo/cssquery-ext.html (next: http://localhost:32793/tests/dromaeo/cssquery-jquery.html) 08:58:56 INFO - PROCESS | 4847 | RSS: Main: 188551168 08:58:56 INFO - PROCESS | 4847 | 09:01:58 INFO - PROCESS | 4847 | Cycle 1(1): loaded http://localhost:32793/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32793/tests/dromaeo/cssquery-mootools.html) 09:01:58 INFO - PROCESS | 4847 | RSS: Main: 188870656 09:01:58 INFO - PROCESS | 4847 | 09:05:00 INFO - PROCESS | 4847 | Cycle 1(1): loaded http://localhost:32793/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32793/tests/dromaeo/cssquery-prototype.html) 09:05:01 INFO - PROCESS | 4847 | RSS: Main: 186601472 09:05:01 INFO - PROCESS | 4847 | 09:08:03 INFO - PROCESS | 4847 | Cycle 1(1): loaded http://localhost:32793/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32793/tests/dromaeo/cssquery-yui.html) 09:08:04 INFO - PROCESS | 4847 | RSS: Main: 188997632 09:08:04 INFO - PROCESS | 4847 | 09:11:06 INFO - PROCESS | 4847 | Cycle 1(1): loaded http://localhost:32793/tests/dromaeo/cssquery-yui.html (next: http://localhost:32793/tests/dromaeo/cssquery-dojo.html) 09:11:07 INFO - PROCESS | 4847 | RSS: Main: 189571072 09:11:07 INFO - PROCESS | 4847 | 09:11:07 INFO - PROCESS | 4847 | __start_tp_report 09:11:07 INFO - PROCESS | 4847 | _x_x_mozilla_page_load 09:11:07 INFO - PROCESS | 4847 | _x_x_mozilla_page_load_details 09:11:07 INFO - PROCESS | 4847 | |i|pagename|runs| 09:11:07 INFO - PROCESS | 4847 | |0;dojo.html;3106.642736085351;3118.8440577971096;3124.5938028056353;3134.9686503134963;3139.293658926741;5409.26974858394;5426.457354264577;5433.18502224666;5442.12925931851;5499.752511136999;5455.18172274159;5473.945260547393;5485.807996720116;5492.450754924505;5574.581906357029;4909.533594308544;4974.1792604220445;5063.987202559484;5100.1074811907765;5155.81954631588;518.039366825342;5039.596832253411;5126.102931986888;5133.127368347371;5169.638125331228;5064.290999260106;5067.873303167432;5092.414372347191;5093.770780314876;5116.2069879168785;5012.423571289312;5095.363079615048;5102.821401250939;5113.437521872591;5118.385793704742;5027.09512287788;5049.772760225798;5057.974710126463;5060.84817455477;5107.514786095315;5538.501534861842;5543.861403464905;5547.916781248285;5555.861103472405;5602.7758889644365;5758.280214973129;5771.88456230873;5836.854078648025;5935.643861368331;5956.910646340309;5889.440503152194;5903.793367232126;5911.29064512257;5912.852178695567;5965.075413310944;5453.291072160633;5457.699826509541;5469.371022332443;5473.8357849264185;5476.561875049986;5901.822945311647;5981.0729336952845;5999.820005399845;6013.639181649028;6054;5819.912701309484;5828.562857785683;5828.970855145697;5833.50415214703;5849.327327357409;5910.822675319747;5912.940870591325;5917.408259174048;5920.763169473173;5923.437273459014;5760.049591817387;5812.447817457335;5881.3530511643685;5903.911441328383;5923.792667256712;5723.885522289531;5852.092925596454;5859.794907178229;5918.171455996164;5921.822345329647;4494.820207191741;4516.525764794715;4524.389207456951;4536.455625324916;4560.429946256718;3982.143839074613;3984.083660758042;4005.499312585927;4009.3184158693093;4035.1526179502634;5584.636998595079;5621.241132447149;5654.15187721845;5661.433856614306;5695.288088988877;5970.2238708968425;5977.043673012384;5998.130271110665;5999.950008748451;6002.399760023963;5459.071957767189;5512.145617429224;5558.249636299129;5579.9163012554845;5586.910552442235;5096.61775366849;5106.770195341219;5111.744412779346;5123.538881500608;5143.408508021551;6112.572119951561;6173.9073913891325;6199.442050215503;6201.6899155042065;6228.750849966042;5827.796027139115;5853.736581853742;5890.028145355968;5920.615160014585;5954.612950158225;6168.722407491584;6181.876362472815;6184.443400094013;6188.44304012641;6191.040388739752;5684.914726279192;5809.622374545641;5849.970750146222;5861.472467477777;5864.648121112747;5857.619254748428;5858;5931.584789064724;5955.166276721176;5956.719305349197;5726.226959360433;5773.04744717117;5777.740001700017;5797.304323481209;5829.15477255804;5697.4302569742695;5798.188253644577;5798.304203495608;5809.535237180931;5830.125481177688;5558.916616250679;5608.158776183605;5631.042722737063;5644.576656750678;5691.203231547669;5767.452092051249;5770.596058276048;5804.100364443518;5819.5053420459735;5823.534117270693;5687.630304030225;5694.829155125353;5695.487406133468;5696.060150075357;5696.715164241688 09:11:07 INFO - PROCESS | 4847 | |1;ext.html;561.3067861191428;624.721998710574;629.9716512756926;641.5701480008393;652.012201514705;38644.61355386449;42929.14141717172;42963;43055.13889722204;43131.56868431315;42931;43434.565654343445;43568.564314356845;43616.781916090375;43682;8934.195922366986;9093.318001149908;9122.22461090808;9139.588718507683;9142.908570914273;8929.508877011762;9001.864972025425;9013.54932253388;9035.412698174598;9037.457752534836;8982.461052336848;9006.68476603319;9022.097790220958;9022.188003079722;9022.413543119708;8972.371933964625;8975.878015248094;8980.775480612972;8987.191152796247;9013.414128081653;8957.059508751618;9035.593398297093;9040.321975851837;9041.819163616756;9060;41560.79219603883;41747.37378939318;41830.79084604588;42003;42041.78979105115;2835.66723639891;3114.7819652624325;3278.3620140216585;3406.403879321109;3459.4983727359645;29380.559291610643;30673.233169170726;31983.680163198303;32259.19352016195;32465.51301730476;4248.4052232687445;4317.201317756225;4343.413639158704;4434.84478043267;4465.0400163964905;337883;338575;339906;340216;340247.9999999975;35227.82386088053;35456.46815297772;35540.644593553734;35560;35730.46404303938;35851.64148358483;36161.276774464364;36395.27209455849;38090.42864357037;38112.8094359532;13319.600411987656;13321;13373.264470454218;13439.18570992923;13449.663758406117;11048.944755276172;11312.943435282936;11317.49071291794;11321.377324247245;11326.37704926237;19960.800391995894;20191;20220;20304.593908121755;20358;7128.465365097639;7190.173130090002;7308.159561650372;7359.926400736032;7450.292222238879;975.8487434447673;994.4928086675848;1030.5980667539666;1062.1020853467792;1086.1907878630313;32422.513662295085;32637.836810815796;32773.83613081967;32856.34287314241;33322;1108.2519299472824;1144.4049094470995;1215.6231568213882;1225.6200577820905;1235.6354875311804;17262.395816146374;17394.47816565505;17467.91688187859;17537.298508059535;17638.118094095244;605061;605150;608246;609053;610225;61635.38364616296;61732;61746.38253617406;62190.0671489928;62374;1332.5336132353598;1337.097459215026;1383.273781264844;1387.5074348606302;1406.5499040307004;32698;33514.162145946546;33670.32659346848;33952.490712638835;34637.48043779295;50682.74658626683;51626.22560661518;51894.221586676984;51943;52069.21896171485;461276;461933;463996;464127;465579;29212.70787292185;29592;29602;29677.851610742673;29781.702182977893;48562;49281.75359123181;49552;50391;50729.23906141337;41723.58276417318;42661.57338426576;42855.3571696431;43506.34740478959;43751.56248437602;41302;41479.37780933349;42082.36876446917;42416.546262641976;42704;36523.26953460969;40691.389629155;41252.38121428121;41607.79196104;41635.7918210407;33974.660253398135;35684.46473302851;35992;36252.63747362493;36418.635813642584;27774.722252777214;27871.72128278691;27908.30229244285;28152.43695126127;28234.294142645776 09:11:07 INFO - PROCESS | 4847 | |2;jquery.html;381.47166174847825;385.5700893503744;387.6162599026963;390.8749200255919;414.03116706905837;17543.473695789115;19034.714479282786;20723.171073157075;20867.060982255796;20894.89552552237;12162.878371216286;12301.815472767916;12334.44494997725;12355.629331120059;17574.82425175748;5177.7928882844735;5412.539934105605;5415.404305526389;5425.6707106758895;5452.127659574468;3883.106885416356;5610.438956104377;5886.087656413263;5890.970545147268;5979.431953964388;5926.733297001645;5967.6121052131475;5969.522438204955;5970.850728731794;6373.649449280288;6459.6447195404235;6607.8017659469815;6609.438197753197;6651.866962660768;6689.632070236159;5728.25532680753;5802.12968054791;5844.5616578756335;5868.325142608612;5922.437368449991;22743.658845117337;23233.883830580908;23381.883090584608;23781.167659131846;23857.88071059651;2167.945801354963;2336.7780060894356;2357.669926210332;2606.1790535981104;2673.625692403065;9187.586558604879;9722.465264410455;9801.509924503745;10283.79432411355;14673.77989330161;1887.4432042547483;1918.4389933416453;1945.9805401946082;1959.4611481842608;1991.9004049797452;79410;83112;83258.58370708108;83338.58330708368;83398;11072.833907491395;11077.778444431066;11310.94344528272;11471.942640286745;11533.135014873918;15525.146116963675;15527.534173974573;15726.606834828992;15747.763783543256;15790.9210453947;7355.5586664800285;7423.888641670379;7461;7633.084029916335;7674.693012279558;6633.502487313471;6757.695903684346;6790.796276111724;6832.043513908056;6834.794956151323;4556.407667003268;4696.624270058387;4771.258490650956;4811.879703007453;4999.150144475448;1816.4750996115147;1886.1323791056268;1919.4145785535266;1946.7663880334167;2000.9199632014847;880.3969281042506;984.2027957354422;1019.5921631347372;1041.510490069666;1041.9322744021615;17894.642107157782;19044;19403.514912127026;19621.901890490455;19659.311924082587;963.4412041016194;981.8036392721484;987.8765154355706;1016.192127258831;1051.6161601015726;10782;11200.38397888124;11208.943955280172;11248.94375528117;11308.208425410307;188482;190076;408699;517289;519969;96032;98302;98528.50735746419;99054;99298.503507482;978.9902100979042;986.1272773595276;994.3337963564285;994.9652361543913;996.725900377402;16281.837181628032;17245.22396492136;17440.73838892392;17664.116794159985;17916.820831791516;41153.76538703844;41252.58747412488;41552.92235388158;42617;43561.56438435575;59664.403355965886;60251.39748602633;60619;61394;61641.38358616536;8873.64505419776;9008.774780630536;9051.547422628973;9152.862707059532;9171.17459428628;10642.361458312525;13749;13791;13866;14195.787063193853;12014;12345.506179752709;12487.718265744252;12593.244405335709;12596.55912043074;12368;12387.75224495487;12389.256644601353;12695.174813637084;12919.483220671444;12338.691532711755;12380.257184568954;12504.874951250371;12695.93652031734;12885.355732213164;8864.157904999272;8916.643334266817;8978.326625502983;9135.223506002065;9329.580168892551;9440;12447.626571202878;12547.560835371083;12746.171498852545;12811.615651530468 09:11:07 INFO - PROCESS | 4847 | |3;mootools.html;1455.6506438454774;1485.1089346392166;1600.975985360219;1742.4946765438024;1758.7186050231965;8031.9598402007905;8581;8677.392582519218;9381.20259777919;9409.62361505539;8700.738977830675;8883.64465421384;8955.552222388887;8970.102989701027;8971.641134354635;2353.1175809071597;2387.2599494156866;2389.689340385756;2390.127603424755;2391.079434417753;2334.451403920086;2348.7181538215436;2378.7859092681656;2383.0348708772976;2383.1301574925114;2351.000824649526;2352.635341522067;2356.964645530318;2357.599208134621;2390.247072172269;2319.52449747803;2329.545738580969;2334.3930578049744;2336.1122773346106;2348.342464110035;2262.7171603549555;2274.1358283852196;2275.590393729128;2284.223364056212;2289.725232972054;8897.065808090121;8968.955155224246;8989.325800564919;9037.367384283103;9055.366124371296;5217.817376391846;5233.345831771028;5243.344581927259;5247.344081989751;5296.629235953485;3342.364950659367;3374.190194353362;3464.2898205867987;3468.0982944434377;3511.0344655219765;1154.792137415265;1165.6794381545144;1197.5988044005182;1202.699325168708;1206.6741979665528;12594.055445841599;12622.747545049047;12628.747425051448;12634.74730505394;12661.62015139538;4596.241620132708;4663.556962088596;4689.531046895351;4704.059188162381;4732.6687131900435;10548.261621686408;10611.31026483276;10631;10635.680929572125;10643.84034239487;5324.600654950894;5329.467053294717;5330.840074797762;5344.91982620261;5346.385165705994;4411.823527058946;4848.490908454562;4851.830185943475;5011.599072074226;5023.547880690682;4084.938725919054;4133.059990722318;4138.151678905817;4152.709310348307;4153.086321009373;1297.8118172864881;1304.8629893861198;1308.215070957418;1310.0567591334225;1312.8424589049375;928.758522784081;1030.6238223048533;1035.5650626736788;1049.9632512862013;1054.6572363981736;6321.0834429008455;6417.550771445954;6458.741650334028;6462.063000864849;6538.476921846336;456.7008609360874;459.73794936885656;467.84794941643423;1035.8239099353127;1056.9471526423647;4368.645719826864;4413.337999300066;4470.977645111819;4474.932876006863;4491.124230774967;11190.440477976068;11602.825957610643;11609;11614.419279036183;11636.88363116375;10780.46097695112;11135.498902549405;11167.49746261404;11542.13433992454;11558.364289963965;8388.37087218461;8427.0730219677;8457;8499;8528.872066919;6254;6423.582467139621;6467.773627923;6513.218413790186;6554.672266386757;10392.844107338246;10440.53017614194;10444.477776111316;10513.264071514921;10587.047165755119;10712.946435267773;10853.186011049362;10854.945725271324;10881.401522916316;10899.618513351994;7397.482176247826;7908;7970.601469926596;8056.1138274788555;8289.378296627656;9026.774330641787;9027.052159523419;9059.229965452747;9128.7261382156;9168.266538677024;7970.362371010189;8190.877136842833;8231.42380033392;8304.916950830415;8398.244158025807;7780.88328675059;7855.685772569033;7946.125926148235;8000.159983201913;8256.091829898827;7001.649917504206;7193.352598266181;7434.070741157356;7457.888131677921;7478.588677622783;5436.103042997861;5448.591355648263;5466.289382380265;5505.9724701376235;5537.723113844372;5754.108113242454;5777.191193232867;5836.095405212199;5839.824805255849;5861.560382971209 09:11:07 INFO - PROCESS | 4847 | |4;prototype.html;319.9136233217033;321.8101320221069;327.2065241788663;328.97360236063486;329.3199542943822;5479.342478902528;5496;5604;5679.062954612489;5679.432056794323;5528.75120619573;5540.168974653794;5540.473655002768;5543.805966791163;5584.720763961806;4366.519682834885;4372.519022907493;4373.650107991353;4393.143337049277;4406.581374769392;4087.4044981436705;4320.935185972213;4321.870343889688;4398.3842262083335;4402.537733537981;4245.490541135068;4273.252180868336;4274.829006839723;4275.444192255002;4297.183535128332;4285.7428554286535;4286.228478873802;4300.892477688051;4314.827406903752;4364.759938203398;3643.234920666663;3725.5529336479794;3730.9440358394645;3741.4013757798893;3741.494898188737;5474.644148130359;5490.149026900836;5514.601148500416;5529.889402211974;5531.751071201806;4862.343583616202;4907.950920490785;4909.459959404463;4969.527894849984;4988.376452943382;5709.571782116316;5841.386654401312;5852.590318677694;5885.205497257858;5905.202797622352;4130.112025914443;4150.8547200848125;4158.542560318362;4163.937540936889;4166.000159961618;5835.708214589254;5993.640381577119;6037.977277611962;6075.362086980892;6091.390860913917;4193.874183774492;4198.118395136994;4198.3702444633545;4216.789160541961;4218.978905105455;4225.64082053029;4257.23369793434;4259.97870010648;4262.6376757975295;4269.573042695705;4873.756312184377;4882.9755851221225;4894;4932.802687892516;4950.133726597831;5606.971965140148;5703.771849125988;5870.941290587125;5873.119032145212;5876.324222714357;1451.9056261342978;1452.7602945514084;1464.7436698577706;1475.896687231905;1476.5644134980207;873.9781505462287;906.5920335848895;917.0279503725939;924.8104138651561;927.3554879358916;4996.701517302009;5004.624653151028;5026.673266237683;5078.238264260391;5106.897862042812;5259.263703081571;5328.973355133199;5353.625246232804;5376.650517716336;5431.2396264522995;5032.572231360376;5057.799857062189;5067;5227.294315267391;5712.942870571324;3167.2873603439043;3190.808551486918;3264.396086723916;3265.591801024872;3271.918202044968;6143.477804386588;6302.684865756693;6306.936930630635;6314.873702525923;6342.873142537123;6121.418465245794;6134.171886795226;6152.507799376039;6157.322694503601;6232.470240029648;6233.407826256498;6243.282022567372;6264.5301602379095;6268.404501572434;6286.119943207955;5715.77110921154;5918.674472904032;5999.820005399671;6034.909476357946;6057.7879774207695;5894.823155305347;5951.464368206882;5960.006795447148;6006.138097189885;6028.2163318770035;5946;6176.845578860385;6178.845528861814;6182.258129024546;6191.907121393273;4122.91754164921;4171.499420069611;4184.476940382452;4198.908283846283;4201.285781417228;5781.277340332458;5811.128330750421;5973.253343332083;6045.939540604713;6101.786437474667;5769.278840144982;5777.382332946781;5800.8259752207505;5819.679917604572;5850.473457388855;5721.8569535761935;5758.337791153904;5791.8552036199435;5800.24596802413;5827.708614569339;5612.494875461228;5632.464915832989;5728.684922329312;5728.713564321684;5764.048931926185;5877.559183061373;5880.735366908585;5885.557493640092;5896.970515147568;5900.852478688067;5700.686462244616;5702.344230413555;5735.512481439125;5786.566007549366;5817.738201780845 09:11:07 INFO - PROCESS | 4847 | |5;yui.html;745.3105877063715;769.9864061678293;800.823818759873;819.9508029518229;836.431226765799;14947.476838310662;16275.186240687963;16315.428959986388;16320.673586528292;16333.428330008452;14559.854401455983;14710.19093949835;14856.18290993995;15180.772288415683;15194.848051519482;789.1595450844832;799.4803377804416;800.2757504458474;801.0187520287631;803.5259197073725;775.3874439193031;794.5868148562744;794.6463823598501;796;796.41861441148;821.995890020549;823.9423240373176;824.1387749801441;824.9298809601161;827.0902007791442;811.2131232704268;815.7797394703426;816.0533780814256;822.7202751064607;823.6170180865867;600.0069884341422;601.0443395001925;601.1283638723825;602.2652364115771;604.6251324178993;14563.417463301455;14759.262036898112;14799.40802367904;14803;14868.776968345483;14760.114393136446;14791.40834366624;14831.77752333716;14863.628409289746;14905.850941490664;12252.791068580578;12355.196912200769;12455.501779928793;12506.999440044865;12564.497420103186;3906.8437262509465;3919.490466239399;3997.2405243004027;4108.4453598764085;4122.690798190148;81905;82832.58583707042;82982.17017829805;83891;83960.99999999939;11509.884901151048;11729.941350293195;11781.528738850522;11829.645110646694;11936;21763.129474821148;21769.346919592437;21809.23667671624;21820.89089554542;21826.563468730856;7789.7273595423885;8321.583920803936;8726.781830454289;8825.558722063872;8854;4456.532064133219;4726.787294571753;4741.454732705714;4958.950410495849;5024.221245706921;3475.652434756504;3556.342076715816;3563.8574457021946;3585.713142948558;3592.1558433768046;620.3269452643932;627.9215098112736;650.9479241660656;651.7262749645066;652.6834485274638;653.4054010850103;705.5131958948309;743.171363929215;758.6775620361325;781.5740421470313;10130.797384052277;10260.897391025994;10306.278560500694;10385.740356490996;10671.626493072705;593.6141508019822;613.0742578706097;624.6002558362652;716.0011783561902;744.5681504727245;4757.976210118927;4766.952330476651;4916.434610019822;4963.975180124076;4975.626827987915;64942.675286623264;119160;120252.3987380075;121894.39052804856;123789;103196;103727;104297.47851260695;105803;107744;88297.99999999872;89162;92008;92301;92518;9405.43567385959;9519.666811661558;9584.520773961134;9668.323217374716;9721.659741909281;37921.81039094787;48966.51033489762;51672.48327516827;52551.737241313545;53401.73299133635;69275.65362173358;69722;75925.62037189779;76859;80942.19057809346;11182.776344473228;11552.6534203974;11571.826422603835;11888.048956083665;11895.821562676394;13067.934660326637;13346.532871349456;13347.466101355836;13443.327833608477;13847.79228311556;13121.278329691577;14137.575872723835;14170.504032358818;14819.851801481847;14884.702305954037;13437.798433023709;13860.861391385957;13962.232077235443;14543.563693089225;14704.485343012942;14028.929855350658;14245.786313205102;14503.419863205354;14629.853701463275;14679.339429725474;11695.590654327058;11700.35648039366;11841.28952262867;12459.190152640049;12461;10476.69824059637;11281.09751219884;12111;12297.508099675913;12535.811962820382 09:11:07 INFO - PROCESS | 4847 | __end_tp_report 09:11:07 INFO - PROCESS | 4847 | __start_cc_report 09:11:07 INFO - PROCESS | 4847 | _x_x_mozilla_cycle_collect,353 09:11:07 INFO - PROCESS | 4847 | __end_cc_report 09:11:07 INFO - PROCESS | 4847 | __startTimestamp1467130267244__endTimestamp 09:11:07 INFO - PROCESS | 4847 | 09:11:07 INFO - PROCESS | 4847 | ------- Summary: start ------- 09:11:07 INFO - PROCESS | 4847 | Number of tests: 6 09:11:07 INFO - PROCESS | 4847 | 09:11:07 INFO - PROCESS | 4847 | [#0] dojo.html Cycles:165 Average:5462.60 Median:5695.29 stddev:736.90 (12.9%) stddev-sans-first:715.61 09:11:07 INFO - PROCESS | 4847 | Values: 3106.6 3118.8 3124.6 3135.0 3139.3 5409.3 5426.5 5433.2 5442.1 5499.8 5455.2 5473.9 5485.8 5492.5 5574.6 4909.5 4974.2 5064.0 5100.1 5155.8 518.0 5039.6 5126.1 5133.1 5169.6 5064.3 5067.9 5092.4 5093.8 5116.2 5012.4 5095.4 5102.8 5113.4 5118.4 5027.1 5049.8 5058.0 5060.8 5107.5 5538.5 5543.9 5547.9 5555.9 5602.8 5758.3 5771.9 5836.9 5935.6 5956.9 5889.4 5903.8 5911.3 5912.9 5965.1 5453.3 5457.7 5469.4 5473.8 5476.6 5901.8 5981.1 5999.8 6013.6 6054.0 5819.9 5828.6 5829.0 5833.5 5849.3 5910.8 5912.9 5917.4 5920.8 5923.4 5760.0 5812.4 5881.4 5903.9 5923.8 5723.9 5852.1 5859.8 5918.2 5921.8 4494.8 4516.5 4524.4 4536.5 4560.4 3982.1 3984.1 4005.5 4009.3 4035.2 5584.6 5621.2 5654.2 5661.4 5695.3 5970.2 5977.0 5998.1 6000.0 6002.4 5459.1 5512.1 5558.2 5579.9 5586.9 5096.6 5106.8 5111.7 5123.5 5143.4 6112.6 6173.9 6199.4 6201.7 6228.8 5827.8 5853.7 5890.0 5920.6 5954.6 6168.7 6181.9 6184.4 6188.4 6191.0 5684.9 5809.6 5850.0 5861.5 5864.6 5857.6 5858.0 5931.6 5955.2 5956.7 5726.2 5773.0 5777.7 5797.3 5829.2 5697.4 5798.2 5798.3 5809.5 5830.1 5558.9 5608.2 5631.0 5644.6 5691.2 5767.5 5770.6 5804.1 5819.5 5823.5 5687.6 5694.8 5695.5 5696.1 5696.7 09:11:07 INFO - PROCESS | 4847 | 09:11:07 INFO - PROCESS | 4847 | [#1] ext.html Cycles:180 Average:61562.40 Median:41621.79 stddev:128644.49 (309.1%) stddev-sans-first:128923.84 09:11:07 INFO - PROCESS | 4847 | Values: 561.3 624.7 630.0 641.6 652.0 38644.6 42929.1 42963.0 43055.1 43131.6 42931.0 43434.6 43568.6 43616.8 43682.0 8934.2 9093.3 9122.2 9139.6 9142.9 8929.5 9001.9 9013.5 9035.4 9037.5 8982.5 9006.7 9022.1 9022.2 9022.4 8972.4 8975.9 8980.8 8987.2 9013.4 8957.1 9035.6 9040.3 9041.8 9060.0 41560.8 41747.4 41830.8 42003.0 42041.8 2835.7 3114.8 3278.4 3406.4 3459.5 29380.6 30673.2 31983.7 32259.2 32465.5 4248.4 4317.2 4343.4 4434.8 4465.0 337883.0 338575.0 339906.0 340216.0 340248.0 35227.8 35456.5 35540.6 35560.0 35730.5 35851.6 36161.3 36395.3 38090.4 38112.8 13319.6 13321.0 13373.3 13439.2 13449.7 11048.9 11312.9 11317.5 11321.4 11326.4 19960.8 20191.0 20220.0 20304.6 20358.0 7128.5 7190.2 7308.2 7359.9 7450.3 975.8 994.5 1030.6 1062.1 1086.2 32422.5 32637.8 32773.8 32856.3 33322.0 1108.3 1144.4 1215.6 1225.6 1235.6 17262.4 17394.5 17467.9 17537.3 17638.1 605061.0 605150.0 608246.0 609053.0 610225.0 61635.4 61732.0 61746.4 62190.1 62374.0 1332.5 1337.1 1383.3 1387.5 1406.5 32698.0 33514.2 33670.3 33952.5 34637.5 50682.7 51626.2 51894.2 51943.0 52069.2 461276.0 461933.0 463996.0 464127.0 465579.0 29212.7 29592.0 29602.0 29677.9 29781.7 48562.0 49281.8 49552.0 50391.0 50729.2 41723.6 42661.6 42855.4 43506.3 43751.6 41302.0 41479.4 42082.4 42416.5 42704.0 36523.3 40691.4 41252.4 41607.8 41635.8 33974.7 35684.5 35992.0 36252.6 36418.6 27774.7 27871.7 27908.3 28152.4 28234.3 09:11:07 INFO - PROCESS | 4847 | 09:11:07 INFO - PROCESS | 4847 | [#2] jquery.html Cycles:180 Average:25808.30 Median:2135.36 stddev:66211.29 (3100.7%) stddev-sans-first:66369.51 09:11:07 INFO - PROCESS | 4847 | Values: 381.5 385.6 387.6 390.9 414.0 17543.5 19034.7 20723.2 20867.1 20894.9 12162.9 12301.8 12334.4 12355.6 17574.8 5177.8 5412.5 5415.4 5425.7 5452.1 3883.1 5610.4 5886.1 5891.0 5979.4 5926.7 5967.6 5969.5 5970.9 6373.6 6459.6 6607.8 6609.4 6651.9 6689.6 5728.3 5802.1 5844.6 5868.3 5922.4 22743.7 23233.9 23381.9 23781.2 23857.9 2167.9 2336.8 2357.7 2606.2 2673.6 9187.6 9722.5 9801.5 10283.8 14673.8 1887.4 1918.4 1946.0 1959.5 1991.9 79410.0 83112.0 83258.6 83338.6 83398.0 11072.8 11077.8 11310.9 11471.9 11533.1 15525.1 15527.5 15726.6 15747.8 15790.9 7355.6 7423.9 7461.0 7633.1 7674.7 6633.5 6757.7 6790.8 6832.0 6834.8 4556.4 4696.6 4771.3 4811.9 4999.2 1816.5 1886.1 1919.4 1946.8 2000.9 880.4 984.2 1019.6 1041.5 1041.9 17894.6 19044.0 19403.5 19621.9 19659.3 963.4 981.8 987.9 1016.2 1051.6 10782.0 11200.4 11208.9 11248.9 11308.2 188482.0 190076.0 408699.0 517289.0 519969.0 96032.0 98302.0 98528.5 99054.0 99298.5 979.0 986.1 994.3 995.0 996.7 16281.8 17245.2 17440.7 17664.1 17916.8 41153.8 41252.6 41552.9 42617.0 43561.6 59664.4 60251.4 60619.0 61394.0 61641.4 8873.6 9008.8 9051.5 9152.9 9171.2 10642.4 13749.0 13791.0 13866.0 14195.8 12014.0 12345.5 12487.7 12593.2 12596.6 12368.0 12387.8 12389.3 12695.2 12919.5 12338.7 12380.3 12504.9 12695.9 12885.4 8864.2 8916.6 8978.3 9135.2 9329.6 9440.0 12447.6 12547.6 12746.2 12811.6 09:11:07 INFO - PROCESS | 4847 | 09:11:07 INFO - PROCESS | 4847 | [#3] mootools.html Cycles:180 Average:6022.33 Median:4483.03 stddev:3441.73 (76.8%) stddev-sans-first:3434.27 09:11:07 INFO - PROCESS | 4847 | Values: 1455.7 1485.1 1601.0 1742.5 1758.7 8032.0 8581.0 8677.4 9381.2 9409.6 8700.7 8883.6 8955.6 8970.1 8971.6 2353.1 2387.3 2389.7 2390.1 2391.1 2334.5 2348.7 2378.8 2383.0 2383.1 2351.0 2352.6 2357.0 2357.6 2390.2 2319.5 2329.5 2334.4 2336.1 2348.3 2262.7 2274.1 2275.6 2284.2 2289.7 8897.1 8969.0 8989.3 9037.4 9055.4 5217.8 5233.3 5243.3 5247.3 5296.6 3342.4 3374.2 3464.3 3468.1 3511.0 1154.8 1165.7 1197.6 1202.7 1206.7 12594.1 12622.7 12628.7 12634.7 12661.6 4596.2 4663.6 4689.5 4704.1 4732.7 10548.3 10611.3 10631.0 10635.7 10643.8 5324.6 5329.5 5330.8 5344.9 5346.4 4411.8 4848.5 4851.8 5011.6 5023.5 4084.9 4133.1 4138.2 4152.7 4153.1 1297.8 1304.9 1308.2 1310.1 1312.8 928.8 1030.6 1035.6 1050.0 1054.7 6321.1 6417.6 6458.7 6462.1 6538.5 456.7 459.7 467.8 1035.8 1056.9 4368.6 4413.3 4471.0 4474.9 4491.1 11190.4 11602.8 11609.0 11614.4 11636.9 10780.5 11135.5 11167.5 11542.1 11558.4 8388.4 8427.1 8457.0 8499.0 8528.9 6254.0 6423.6 6467.8 6513.2 6554.7 10392.8 10440.5 10444.5 10513.3 10587.0 10712.9 10853.2 10854.9 10881.4 10899.6 7397.5 7908.0 7970.6 8056.1 8289.4 9026.8 9027.1 9059.2 9128.7 9168.3 7970.4 8190.9 8231.4 8304.9 8398.2 7780.9 7855.7 7946.1 8000.2 8256.1 7001.6 7193.4 7434.1 7457.9 7478.6 5436.1 5448.6 5466.3 5506.0 5537.7 5754.1 5777.2 5836.1 5839.8 5861.6 09:11:07 INFO - PROCESS | 4847 | 09:11:07 INFO - PROCESS | 4847 | [#4] prototype.html Cycles:180 Average:4862.17 Median:5530.82 stddev:1446.38 (26.2%) stddev-sans-first:1409.69 09:11:07 INFO - PROCESS | 4847 | Values: 319.9 321.8 327.2 329.0 329.3 5479.3 5496.0 5604.0 5679.1 5679.4 5528.8 5540.2 5540.5 5543.8 5584.7 4366.5 4372.5 4373.7 4393.1 4406.6 4087.4 4320.9 4321.9 4398.4 4402.5 4245.5 4273.3 4274.8 4275.4 4297.2 4285.7 4286.2 4300.9 4314.8 4364.8 3643.2 3725.6 3730.9 3741.4 3741.5 5474.6 5490.1 5514.6 5529.9 5531.8 4862.3 4908.0 4909.5 4969.5 4988.4 5709.6 5841.4 5852.6 5885.2 5905.2 4130.1 4150.9 4158.5 4163.9 4166.0 5835.7 5993.6 6038.0 6075.4 6091.4 4193.9 4198.1 4198.4 4216.8 4219.0 4225.6 4257.2 4260.0 4262.6 4269.6 4873.8 4883.0 4894.0 4932.8 4950.1 5607.0 5703.8 5870.9 5873.1 5876.3 1451.9 1452.8 1464.7 1475.9 1476.6 874.0 906.6 917.0 924.8 927.4 4996.7 5004.6 5026.7 5078.2 5106.9 5259.3 5329.0 5353.6 5376.7 5431.2 5032.6 5057.8 5067.0 5227.3 5712.9 3167.3 3190.8 3264.4 3265.6 3271.9 6143.5 6302.7 6306.9 6314.9 6342.9 6121.4 6134.2 6152.5 6157.3 6232.5 6233.4 6243.3 6264.5 6268.4 6286.1 5715.8 5918.7 5999.8 6034.9 6057.8 5894.8 5951.5 5960.0 6006.1 6028.2 5946.0 6176.8 6178.8 6182.3 6191.9 4122.9 4171.5 4184.5 4198.9 4201.3 5781.3 5811.1 5973.3 6045.9 6101.8 5769.3 5777.4 5800.8 5819.7 5850.5 5721.9 5758.3 5791.9 5800.2 5827.7 5612.5 5632.5 5728.7 5728.7 5764.0 5877.6 5880.7 5885.6 5897.0 5900.9 5700.7 5702.3 5735.5 5786.6 5817.7 09:11:07 INFO - PROCESS | 4847 | 09:11:07 INFO - PROCESS | 4847 | [#5] yui.html Cycles:180 Average:21187.56 Median:3913.17 stddev:30763.78 (786.2%) stddev-sans-first:30811.79 09:11:07 INFO - PROCESS | 4847 | Values: 745.3 770.0 800.8 820.0 836.4 14947.5 16275.2 16315.4 16320.7 16333.4 14559.9 14710.2 14856.2 15180.8 15194.8 789.2 799.5 800.3 801.0 803.5 775.4 794.6 794.6 796.0 796.4 822.0 823.9 824.1 824.9 827.1 811.2 815.8 816.1 822.7 823.6 600.0 601.0 601.1 602.3 604.6 14563.4 14759.3 14799.4 14803.0 14868.8 14760.1 14791.4 14831.8 14863.6 14905.9 12252.8 12355.2 12455.5 12507.0 12564.5 3906.8 3919.5 3997.2 4108.4 4122.7 81905.0 82832.6 82982.2 83891.0 83961.0 11509.9 11729.9 11781.5 11829.6 11936.0 21763.1 21769.3 21809.2 21820.9 21826.6 7789.7 8321.6 8726.8 8825.6 8854.0 4456.5 4726.8 4741.5 4959.0 5024.2 3475.7 3556.3 3563.9 3585.7 3592.2 620.3 627.9 650.9 651.7 652.7 653.4 705.5 743.2 758.7 781.6 10130.8 10260.9 10306.3 10385.7 10671.6 593.6 613.1 624.6 716.0 744.6 4758.0 4767.0 4916.4 4964.0 4975.6 64942.7 119160.0 120252.4 121894.4 123789.0 103196.0 103727.0 104297.5 105803.0 107744.0 88298.0 89162.0 92008.0 92301.0 92518.0 9405.4 9519.7 9584.5 9668.3 9721.7 37921.8 48966.5 51672.5 52551.7 53401.7 69275.7 69722.0 75925.6 76859.0 80942.2 11182.8 11552.7 11571.8 11888.0 11895.8 13067.9 13346.5 13347.5 13443.3 13847.8 13121.3 14137.6 14170.5 14819.9 14884.7 13437.8 13860.9 13962.2 14543.6 14704.5 14028.9 14245.8 14503.4 14629.9 14679.3 11695.6 11700.4 11841.3 12459.2 12461.0 10476.7 11281.1 12111.0 12297.5 12535.8 09:11:07 INFO - PROCESS | 4847 | -------- Summary: end -------- 09:11:07 INFO - PROCESS | 4847 | 09:11:07 INFO - TEST-INFO | 4847: exit 0 09:11:07 INFO - TEST-OK | dromaeo_css | took 1111444ms 09:11:07 INFO - TEST-START | kraken 09:11:07 INFO - operating with platform_type : linux_ 09:11:07 INFO - Initialising browser for kraken test... 09:11:07 INFO - TEST-INFO | started process 5087 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpC0lejf/profile http://localhost:32793/getInfo.html) 09:11:12 INFO - PROCESS | 5087 | __metrics Screen width/height:1600/1200 09:11:12 INFO - PROCESS | 5087 | colorDepth:24 09:11:12 INFO - PROCESS | 5087 | Browser inner width/height: 1024/697 09:11:12 INFO - PROCESS | 5087 | __metrics 09:11:13 ERROR - PROCESS | 5087 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 09:11:14 INFO - TEST-INFO | 5087: exit 0 09:11:14 INFO - Browser initialized. 09:11:14 INFO - Running cycle 1/1 for kraken test... 09:11:14 INFO - TEST-INFO | started process 5208 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpC0lejf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:11:26 INFO - PROCESS | 5208 | RSS: Main: 185303040 09:11:26 INFO - PROCESS | 5208 | 09:11:28 INFO - PROCESS | 5208 | Cycle 1(1): loaded http://localhost:32793/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32793/tests/kraken/driver.html?testName=audio-beat-detection) 09:11:29 INFO - PROCESS | 5208 | RSS: Main: 190681088 09:11:29 INFO - PROCESS | 5208 | 09:11:32 INFO - PROCESS | 5208 | Cycle 1(1): loaded http://localhost:32793/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32793/tests/kraken/driver.html?testName=audio-dft) 09:11:33 INFO - PROCESS | 5208 | RSS: Main: 189648896 09:11:33 INFO - PROCESS | 5208 | 09:11:35 INFO - PROCESS | 5208 | Cycle 1(1): loaded http://localhost:32793/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32793/tests/kraken/driver.html?testName=audio-fft) 09:11:36 INFO - PROCESS | 5208 | RSS: Main: 184741888 09:11:36 INFO - PROCESS | 5208 | 09:11:38 INFO - PROCESS | 5208 | Cycle 1(1): loaded http://localhost:32793/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32793/tests/kraken/driver.html?testName=audio-oscillator) 09:11:39 INFO - PROCESS | 5208 | RSS: Main: 185446400 09:11:39 INFO - PROCESS | 5208 | 09:11:41 INFO - PROCESS | 5208 | Cycle 1(1): loaded http://localhost:32793/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32793/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:11:42 INFO - PROCESS | 5208 | RSS: Main: 185655296 09:11:42 INFO - PROCESS | 5208 | 09:11:45 INFO - PROCESS | 5208 | Cycle 1(1): loaded http://localhost:32793/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32793/tests/kraken/driver.html?testName=imaging-darkroom) 09:11:45 INFO - PROCESS | 5208 | RSS: Main: 186101760 09:11:45 INFO - PROCESS | 5208 | 09:11:49 INFO - PROCESS | 5208 | Cycle 1(1): loaded http://localhost:32793/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32793/tests/kraken/driver.html?testName=imaging-desaturate) 09:11:49 INFO - PROCESS | 5208 | RSS: Main: 186257408 09:11:49 INFO - PROCESS | 5208 | 09:11:52 INFO - PROCESS | 5208 | Cycle 1(1): loaded http://localhost:32793/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32793/tests/kraken/driver.html?testName=json-parse-financial) 09:11:53 INFO - PROCESS | 5208 | RSS: Main: 186089472 09:11:53 INFO - PROCESS | 5208 | 09:11:54 INFO - PROCESS | 5208 | Cycle 1(1): loaded http://localhost:32793/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32793/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:11:55 INFO - PROCESS | 5208 | RSS: Main: 185933824 09:11:55 INFO - PROCESS | 5208 | 09:11:57 INFO - PROCESS | 5208 | Cycle 1(1): loaded http://localhost:32793/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32793/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:11:57 INFO - PROCESS | 5208 | RSS: Main: 186195968 09:11:57 INFO - PROCESS | 5208 | 09:11:59 INFO - PROCESS | 5208 | Cycle 1(1): loaded http://localhost:32793/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32793/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:12:00 INFO - PROCESS | 5208 | RSS: Main: 186724352 09:12:00 INFO - PROCESS | 5208 | 09:12:03 INFO - PROCESS | 5208 | Cycle 1(1): loaded http://localhost:32793/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32793/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:12:03 INFO - PROCESS | 5208 | RSS: Main: 187670528 09:12:03 INFO - PROCESS | 5208 | 09:12:06 INFO - PROCESS | 5208 | Cycle 1(1): loaded http://localhost:32793/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32793/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:12:07 INFO - PROCESS | 5208 | RSS: Main: 187207680 09:12:07 INFO - PROCESS | 5208 | 09:12:08 INFO - PROCESS | 5208 | Cycle 1(1): loaded http://localhost:32793/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32793/tests/kraken/driver.html?testName=ai-astar) 09:12:09 INFO - PROCESS | 5208 | RSS: Main: 187928576 09:12:09 INFO - PROCESS | 5208 | 09:12:09 INFO - PROCESS | 5208 | __start_tp_report 09:12:09 INFO - PROCESS | 5208 | _x_x_mozilla_page_load 09:12:09 INFO - PROCESS | 5208 | _x_x_mozilla_page_load_details 09:12:09 INFO - PROCESS | 5208 | |i|pagename|runs| 09:12:09 INFO - PROCESS | 5208 | |0;ai-astar;103;109;106;112;115;112;111;110;112;115 09:12:09 INFO - PROCESS | 5208 | |1;audio-beat-detection;155;128;158;179;129;164;156;128;187;140 09:12:09 INFO - PROCESS | 5208 | |2;audio-dft;164;162;163;161;163;171;163;162;165;164 09:12:09 INFO - PROCESS | 5208 | |3;audio-fft;75;75;76;160;76;75;75;75;161;75 09:12:09 INFO - PROCESS | 5208 | |4;audio-oscillator;85;84;147;85;86;86;132;86;85;152 09:12:09 INFO - PROCESS | 5208 | |5;imaging-gaussian-blur;117;119;117;117;117;117;118;117;117;119 09:12:09 INFO - PROCESS | 5208 | |6;imaging-darkroom;147;148;148;148;148;149;148;147;147;148 09:12:09 INFO - PROCESS | 5208 | |7;imaging-desaturate;100;102;96;96;95;95;97;96;95;96 09:12:09 INFO - PROCESS | 5208 | |8;json-parse-financial;53;52;54;52;54;51;52;58;54;56 09:12:09 INFO - PROCESS | 5208 | |9;json-stringify-tinderbox;64;63;63;63;62;63;62;62;63;63 09:12:09 INFO - PROCESS | 5208 | |10;stanford-crypto-aes;83;78;80;79;80;83;81;80;94;79 09:12:09 INFO - PROCESS | 5208 | |11;stanford-crypto-ccm;132;131;124;125;134;123;129;124;124;124 09:12:09 INFO - PROCESS | 5208 | |12;stanford-crypto-pbkdf2;157;162;155;164;164;159;164;161;156;162 09:12:09 INFO - PROCESS | 5208 | |13;stanford-crypto-sha256-iterative;62;65;63;62;63;63;62;65;62;63 09:12:09 INFO - PROCESS | 5208 | __end_tp_report 09:12:09 INFO - PROCESS | 5208 | __start_cc_report 09:12:09 INFO - PROCESS | 5208 | _x_x_mozilla_cycle_collect,877 09:12:09 INFO - PROCESS | 5208 | __end_cc_report 09:12:09 INFO - PROCESS | 5208 | __startTimestamp1467130329057__endTimestamp 09:12:09 INFO - PROCESS | 5208 | 09:12:09 INFO - PROCESS | 5208 | ------- Summary: start ------- 09:12:09 INFO - PROCESS | 5208 | Number of tests: 14 09:12:09 INFO - PROCESS | 5208 | 09:12:09 INFO - PROCESS | 5208 | [#0] ai-astar Cycles:10 Average:110.50 Median:112.00 stddev:3.75 (3.3%) stddev-sans-first:2.83 09:12:09 INFO - PROCESS | 5208 | Values: 103.0 109.0 106.0 112.0 115.0 112.0 111.0 110.0 112.0 115.0 09:12:09 INFO - PROCESS | 5208 | 09:12:09 INFO - PROCESS | 5208 | [#1] audio-beat-detection Cycles:10 Average:152.40 Median:157.00 stddev:21.04 (13.4%) stddev-sans-first:22.29 09:12:09 INFO - PROCESS | 5208 | Values: 155.0 128.0 158.0 179.0 129.0 164.0 156.0 128.0 187.0 140.0 09:12:09 INFO - PROCESS | 5208 | 09:12:09 INFO - PROCESS | 5208 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.50 stddev:2.78 (1.7%) stddev-sans-first:2.95 09:12:09 INFO - PROCESS | 5208 | Values: 164.0 162.0 163.0 161.0 163.0 171.0 163.0 162.0 165.0 164.0 09:12:09 INFO - PROCESS | 5208 | 09:12:09 INFO - PROCESS | 5208 | [#3] audio-fft Cycles:10 Average:92.30 Median:75.00 stddev:35.95 (47.9%) stddev-sans-first:37.58 09:12:09 INFO - PROCESS | 5208 | Values: 75.0 75.0 76.0 160.0 76.0 75.0 75.0 75.0 161.0 75.0 09:12:09 INFO - PROCESS | 5208 | 09:12:09 INFO - PROCESS | 5208 | [#4] audio-oscillator Cycles:10 Average:102.80 Median:85.00 stddev:28.63 (33.7%) stddev-sans-first:29.63 09:12:09 INFO - PROCESS | 5208 | Values: 85.0 84.0 147.0 85.0 86.0 86.0 132.0 86.0 85.0 152.0 09:12:09 INFO - PROCESS | 5208 | 09:12:09 INFO - PROCESS | 5208 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.00 stddev:0.85 (0.7%) stddev-sans-first:0.88 09:12:09 INFO - PROCESS | 5208 | Values: 117.0 119.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 119.0 09:12:09 INFO - PROCESS | 5208 | 09:12:09 INFO - PROCESS | 5208 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 09:12:09 INFO - PROCESS | 5208 | Values: 147.0 148.0 148.0 148.0 148.0 149.0 148.0 147.0 147.0 148.0 09:12:09 INFO - PROCESS | 5208 | 09:12:09 INFO - PROCESS | 5208 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:96.00 stddev:2.35 (2.4%) stddev-sans-first:2.19 09:12:09 INFO - PROCESS | 5208 | Values: 100.0 102.0 96.0 96.0 95.0 95.0 97.0 96.0 95.0 96.0 09:12:09 INFO - PROCESS | 5208 | 09:12:09 INFO - PROCESS | 5208 | [#8] json-parse-financial Cycles:10 Average:53.60 Median:54.00 stddev:2.12 (3.9%) stddev-sans-first:2.24 09:12:09 INFO - PROCESS | 5208 | Values: 53.0 52.0 54.0 52.0 54.0 51.0 52.0 58.0 54.0 56.0 09:12:09 INFO - PROCESS | 5208 | 09:12:09 INFO - PROCESS | 5208 | [#9] json-stringify-tinderbox Cycles:10 Average:62.80 Median:63.00 stddev:0.63 (1.0%) stddev-sans-first:0.50 09:12:09 INFO - PROCESS | 5208 | Values: 64.0 63.0 63.0 63.0 62.0 63.0 62.0 62.0 63.0 63.0 09:12:09 INFO - PROCESS | 5208 | 09:12:09 INFO - PROCESS | 5208 | [#10] stanford-crypto-aes Cycles:10 Average:81.70 Median:80.50 stddev:4.62 (5.7%) stddev-sans-first:4.88 09:12:09 INFO - PROCESS | 5208 | Values: 83.0 78.0 80.0 79.0 80.0 83.0 81.0 80.0 94.0 79.0 09:12:09 INFO - PROCESS | 5208 | 09:12:09 INFO - PROCESS | 5208 | [#11] stanford-crypto-ccm Cycles:10 Average:127.00 Median:127.00 stddev:4.08 (3.2%) stddev-sans-first:3.91 09:12:09 INFO - PROCESS | 5208 | Values: 132.0 131.0 124.0 125.0 134.0 123.0 129.0 124.0 124.0 124.0 09:12:09 INFO - PROCESS | 5208 | 09:12:09 INFO - PROCESS | 5208 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.40 Median:162.00 stddev:3.44 (2.1%) stddev-sans-first:3.42 09:12:09 INFO - PROCESS | 5208 | Values: 157.0 162.0 155.0 164.0 164.0 159.0 164.0 161.0 156.0 162.0 09:12:09 INFO - PROCESS | 5208 | 09:12:09 INFO - PROCESS | 5208 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:63.00 stddev:1.15 (1.8%) stddev-sans-first:1.17 09:12:09 INFO - PROCESS | 5208 | Values: 62.0 65.0 63.0 62.0 63.0 63.0 62.0 65.0 62.0 63.0 09:12:09 INFO - PROCESS | 5208 | -------- Summary: end -------- 09:12:09 INFO - PROCESS | 5208 | 09:12:09 INFO - TEST-INFO | 5208: exit 0 09:12:10 INFO - TEST-OK | kraken | took 62087ms 09:12:10 INFO - SUITE-END | took 1173s 09:12:10 INFO - Completed test suite (00:19:33) 09:12:10 INFO - javascript benchmark 09:12:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7341.696447470411, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3106.642736085351, 3118.8440577971096, 3124.5938028056353, 3134.9686503134963, 3139.293658926741, 5409.26974858394, 5426.457354264577, 5433.18502224666, 5442.12925931851, 5499.752511136999, 5455.18172274159, 5473.945260547393, 5485.807996720116, 5492.450754924505, 5574.581906357029, 4909.533594308544, 4974.1792604220445, 5063.987202559484, 5100.1074811907765, 5155.81954631588, 518.039366825342, 5039.596832253411, 5126.102931986888, 5133.127368347371, 5169.638125331228, 5064.290999260106, 5067.873303167432, 5092.414372347191, 5093.770780314876, 5116.2069879168785, 5012.423571289312, 5095.363079615048, 5102.821401250939, 5113.437521872591, 5118.385793704742, 5027.09512287788, 5049.772760225798, 5057.974710126463, 5060.84817455477, 5107.514786095315, 5538.501534861842, 5543.861403464905, 5547.916781248285, 5555.861103472405, 5602.7758889644365, 5758.280214973129, 5771.88456230873, 5836.854078648025, 5935.643861368331, 5956.910646340309, 5889.440503152194, 5903.793367232126, 5911.29064512257, 5912.852178695567, 5965.075413310944, 5453.291072160633, 5457.699826509541, 5469.371022332443, 5473.8357849264185, 5476.561875049986, 5901.822945311647, 5981.0729336952845, 5999.820005399845, 6013.639181649028, 6054.0, 5819.912701309484, 5828.562857785683, 5828.970855145697, 5833.50415214703, 5849.327327357409, 5910.822675319747, 5912.940870591325, 5917.408259174048, 5920.763169473173, 5923.437273459014, 5760.049591817387, 5812.447817457335, 5881.3530511643685, 5903.911441328383, 5923.792667256712, 5723.885522289531, 5852.092925596454, 5859.794907178229, 5918.171455996164, 5921.822345329647, 4494.820207191741, 4516.525764794715, 4524.389207456951, 4536.455625324916, 4560.429946256718, 3982.143839074613, 3984.083660758042, 4005.499312585927, 4009.3184158693093, 4035.1526179502634, 5584.636998595079, 5621.241132447149, 5654.15187721845, 5661.433856614306, 5695.288088988877, 5970.2238708968425, 5977.043673012384, 5998.130271110665, 5999.950008748451, 6002.399760023963, 5459.071957767189, 5512.145617429224, 5558.249636299129, 5579.9163012554845, 5586.910552442235, 5096.61775366849, 5106.770195341219, 5111.744412779346, 5123.538881500608, 5143.408508021551, 6112.572119951561, 6173.9073913891325, 6199.442050215503, 6201.6899155042065, 6228.750849966042, 5827.796027139115, 5853.736581853742, 5890.028145355968, 5920.615160014585, 5954.612950158225, 6168.722407491584, 6181.876362472815, 6184.443400094013, 6188.44304012641, 6191.040388739752, 5684.914726279192, 5809.622374545641, 5849.970750146222, 5861.472467477777, 5864.648121112747, 5857.619254748428, 5858.0, 5931.584789064724, 5955.166276721176, 5956.719305349197, 5726.226959360433, 5773.04744717117, 5777.740001700017, 5797.304323481209, 5829.15477255804, 5697.4302569742695, 5798.188253644577, 5798.304203495608, 5809.535237180931, 5830.125481177688, 5558.916616250679, 5608.158776183605, 5631.042722737063, 5644.576656750678, 5691.203231547669, 5767.452092051249, 5770.596058276048, 5804.100364443518, 5819.5053420459735, 5823.534117270693, 5687.630304030225, 5694.829155125353, 5695.487406133468, 5696.060150075357, 5696.715164241688], "value": 5414.492530992628, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.3067861191428, 624.721998710574, 629.9716512756926, 641.5701480008393, 652.012201514705, 38644.61355386449, 42929.14141717172, 42963.0, 43055.13889722204, 43131.56868431315, 42931.0, 43434.565654343445, 43568.564314356845, 43616.781916090375, 43682.0, 8934.195922366986, 9093.318001149908, 9122.22461090808, 9139.588718507683, 9142.908570914273, 8929.508877011762, 9001.864972025425, 9013.54932253388, 9035.412698174598, 9037.457752534836, 8982.461052336848, 9006.68476603319, 9022.097790220958, 9022.188003079722, 9022.413543119708, 8972.371933964625, 8975.878015248094, 8980.775480612972, 8987.191152796247, 9013.414128081653, 8957.059508751618, 9035.593398297093, 9040.321975851837, 9041.819163616756, 9060.0, 41560.79219603883, 41747.37378939318, 41830.79084604588, 42003.0, 42041.78979105115, 2835.66723639891, 3114.7819652624325, 3278.3620140216585, 3406.403879321109, 3459.4983727359645, 29380.559291610643, 30673.233169170726, 31983.680163198303, 32259.19352016195, 32465.51301730476, 4248.4052232687445, 4317.201317756225, 4343.413639158704, 4434.84478043267, 4465.0400163964905, 337883.0, 338575.0, 339906.0, 340216.0, 340247.9999999975, 35227.82386088053, 35456.46815297772, 35540.644593553734, 35560.0, 35730.46404303938, 35851.64148358483, 36161.276774464364, 36395.27209455849, 38090.42864357037, 38112.8094359532, 13319.600411987656, 13321.0, 13373.264470454218, 13439.18570992923, 13449.663758406117, 11048.944755276172, 11312.943435282936, 11317.49071291794, 11321.377324247245, 11326.37704926237, 19960.800391995894, 20191.0, 20220.0, 20304.593908121755, 20358.0, 7128.465365097639, 7190.173130090002, 7308.159561650372, 7359.926400736032, 7450.292222238879, 975.8487434447673, 994.4928086675848, 1030.5980667539666, 1062.1020853467792, 1086.1907878630313, 32422.513662295085, 32637.836810815796, 32773.83613081967, 32856.34287314241, 33322.0, 1108.2519299472824, 1144.4049094470995, 1215.6231568213882, 1225.6200577820905, 1235.6354875311804, 17262.395816146374, 17394.47816565505, 17467.91688187859, 17537.298508059535, 17638.118094095244, 605061.0, 605150.0, 608246.0, 609053.0, 610225.0, 61635.38364616296, 61732.0, 61746.38253617406, 62190.0671489928, 62374.0, 1332.5336132353598, 1337.097459215026, 1383.273781264844, 1387.5074348606302, 1406.5499040307004, 32698.0, 33514.162145946546, 33670.32659346848, 33952.490712638835, 34637.48043779295, 50682.74658626683, 51626.22560661518, 51894.221586676984, 51943.0, 52069.21896171485, 461276.0, 461933.0, 463996.0, 464127.0, 465579.0, 29212.70787292185, 29592.0, 29602.0, 29677.851610742673, 29781.702182977893, 48562.0, 49281.75359123181, 49552.0, 50391.0, 50729.23906141337, 41723.58276417318, 42661.57338426576, 42855.3571696431, 43506.34740478959, 43751.56248437602, 41302.0, 41479.37780933349, 42082.36876446917, 42416.546262641976, 42704.0, 36523.26953460969, 40691.389629155, 41252.38121428121, 41607.79196104, 41635.7918210407, 33974.660253398135, 35684.46473302851, 35992.0, 36252.63747362493, 36418.635813642584, 27774.722252777214, 27871.72128278691, 27908.30229244285, 28152.43695126127, 28234.294142645776], "value": 19681.33155943878, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.47166174847825, 385.5700893503744, 387.6162599026963, 390.8749200255919, 414.03116706905837, 17543.473695789115, 19034.714479282786, 20723.171073157075, 20867.060982255796, 20894.89552552237, 12162.878371216286, 12301.815472767916, 12334.44494997725, 12355.629331120059, 17574.82425175748, 5177.7928882844735, 5412.539934105605, 5415.404305526389, 5425.6707106758895, 5452.127659574468, 3883.106885416356, 5610.438956104377, 5886.087656413263, 5890.970545147268, 5979.431953964388, 5926.733297001645, 5967.6121052131475, 5969.522438204955, 5970.850728731794, 6373.649449280288, 6459.6447195404235, 6607.8017659469815, 6609.438197753197, 6651.866962660768, 6689.632070236159, 5728.25532680753, 5802.12968054791, 5844.5616578756335, 5868.325142608612, 5922.437368449991, 22743.658845117337, 23233.883830580908, 23381.883090584608, 23781.167659131846, 23857.88071059651, 2167.945801354963, 2336.7780060894356, 2357.669926210332, 2606.1790535981104, 2673.625692403065, 9187.586558604879, 9722.465264410455, 9801.509924503745, 10283.79432411355, 14673.77989330161, 1887.4432042547483, 1918.4389933416453, 1945.9805401946082, 1959.4611481842608, 1991.9004049797452, 79410.0, 83112.0, 83258.58370708108, 83338.58330708368, 83398.0, 11072.833907491395, 11077.778444431066, 11310.94344528272, 11471.942640286745, 11533.135014873918, 15525.146116963675, 15527.534173974573, 15726.606834828992, 15747.763783543256, 15790.9210453947, 7355.5586664800285, 7423.888641670379, 7461.0, 7633.084029916335, 7674.693012279558, 6633.502487313471, 6757.695903684346, 6790.796276111724, 6832.043513908056, 6834.794956151323, 4556.407667003268, 4696.624270058387, 4771.258490650956, 4811.879703007453, 4999.150144475448, 1816.4750996115147, 1886.1323791056268, 1919.4145785535266, 1946.7663880334167, 2000.9199632014847, 880.3969281042506, 984.2027957354422, 1019.5921631347372, 1041.510490069666, 1041.9322744021615, 17894.642107157782, 19044.0, 19403.514912127026, 19621.901890490455, 19659.311924082587, 963.4412041016194, 981.8036392721484, 987.8765154355706, 1016.192127258831, 1051.6161601015726, 10782.0, 11200.38397888124, 11208.943955280172, 11248.94375528117, 11308.208425410307, 188482.0, 190076.0, 408699.0, 517289.0, 519969.0, 96032.0, 98302.0, 98528.50735746419, 99054.0, 99298.503507482, 978.9902100979042, 986.1272773595276, 994.3337963564285, 994.9652361543913, 996.725900377402, 16281.837181628032, 17245.22396492136, 17440.73838892392, 17664.116794159985, 17916.820831791516, 41153.76538703844, 41252.58747412488, 41552.92235388158, 42617.0, 43561.56438435575, 59664.403355965886, 60251.39748602633, 60619.0, 61394.0, 61641.38358616536, 8873.64505419776, 9008.774780630536, 9051.547422628973, 9152.862707059532, 9171.17459428628, 10642.361458312525, 13749.0, 13791.0, 13866.0, 14195.787063193853, 12014.0, 12345.506179752709, 12487.718265744252, 12593.244405335709, 12596.55912043074, 12368.0, 12387.75224495487, 12389.256644601353, 12695.174813637084, 12919.483220671444, 12338.691532711755, 12380.257184568954, 12504.874951250371, 12695.93652031734, 12885.355732213164, 8864.157904999272, 8916.643334266817, 8978.326625502983, 9135.223506002065, 9329.580168892551, 9440.0, 12447.626571202878, 12547.560835371083, 12746.171498852545, 12811.615651530468], "value": 9192.037593696463, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1455.6506438454774, 1485.1089346392166, 1600.975985360219, 1742.4946765438024, 1758.7186050231965, 8031.9598402007905, 8581.0, 8677.392582519218, 9381.20259777919, 9409.62361505539, 8700.738977830675, 8883.64465421384, 8955.552222388887, 8970.102989701027, 8971.641134354635, 2353.1175809071597, 2387.2599494156866, 2389.689340385756, 2390.127603424755, 2391.079434417753, 2334.451403920086, 2348.7181538215436, 2378.7859092681656, 2383.0348708772976, 2383.1301574925114, 2351.000824649526, 2352.635341522067, 2356.964645530318, 2357.599208134621, 2390.247072172269, 2319.52449747803, 2329.545738580969, 2334.3930578049744, 2336.1122773346106, 2348.342464110035, 2262.7171603549555, 2274.1358283852196, 2275.590393729128, 2284.223364056212, 2289.725232972054, 8897.065808090121, 8968.955155224246, 8989.325800564919, 9037.367384283103, 9055.366124371296, 5217.817376391846, 5233.345831771028, 5243.344581927259, 5247.344081989751, 5296.629235953485, 3342.364950659367, 3374.190194353362, 3464.2898205867987, 3468.0982944434377, 3511.0344655219765, 1154.792137415265, 1165.6794381545144, 1197.5988044005182, 1202.699325168708, 1206.6741979665528, 12594.055445841599, 12622.747545049047, 12628.747425051448, 12634.74730505394, 12661.62015139538, 4596.241620132708, 4663.556962088596, 4689.531046895351, 4704.059188162381, 4732.6687131900435, 10548.261621686408, 10611.31026483276, 10631.0, 10635.680929572125, 10643.84034239487, 5324.600654950894, 5329.467053294717, 5330.840074797762, 5344.91982620261, 5346.385165705994, 4411.823527058946, 4848.490908454562, 4851.830185943475, 5011.599072074226, 5023.547880690682, 4084.938725919054, 4133.059990722318, 4138.151678905817, 4152.709310348307, 4153.086321009373, 1297.8118172864881, 1304.8629893861198, 1308.215070957418, 1310.0567591334225, 1312.8424589049375, 928.758522784081, 1030.6238223048533, 1035.5650626736788, 1049.9632512862013, 1054.6572363981736, 6321.0834429008455, 6417.550771445954, 6458.741650334028, 6462.063000864849, 6538.476921846336, 456.7008609360874, 459.73794936885656, 467.84794941643423, 1035.8239099353127, 1056.9471526423647, 4368.645719826864, 4413.337999300066, 4470.977645111819, 4474.932876006863, 4491.124230774967, 11190.440477976068, 11602.825957610643, 11609.0, 11614.419279036183, 11636.88363116375, 10780.46097695112, 11135.498902549405, 11167.49746261404, 11542.13433992454, 11558.364289963965, 8388.37087218461, 8427.0730219677, 8457.0, 8499.0, 8528.872066919, 6254.0, 6423.582467139621, 6467.773627923, 6513.218413790186, 6554.672266386757, 10392.844107338246, 10440.53017614194, 10444.477776111316, 10513.264071514921, 10587.047165755119, 10712.946435267773, 10853.186011049362, 10854.945725271324, 10881.401522916316, 10899.618513351994, 7397.482176247826, 7908.0, 7970.601469926596, 8056.1138274788555, 8289.378296627656, 9026.774330641787, 9027.052159523419, 9059.229965452747, 9128.7261382156, 9168.266538677024, 7970.362371010189, 8190.877136842833, 8231.42380033392, 8304.916950830415, 8398.244158025807, 7780.88328675059, 7855.685772569033, 7946.125926148235, 8000.159983201913, 8256.091829898827, 7001.649917504206, 7193.352598266181, 7434.070741157356, 7457.888131677921, 7478.588677622783, 5436.103042997861, 5448.591355648263, 5466.289382380265, 5505.9724701376235, 5537.723113844372, 5754.108113242454, 5777.191193232867, 5836.095405212199, 5839.824805255849, 5861.560382971209], "value": 4770.356815161167, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.9136233217033, 321.8101320221069, 327.2065241788663, 328.97360236063486, 329.3199542943822, 5479.342478902528, 5496.0, 5604.0, 5679.062954612489, 5679.432056794323, 5528.75120619573, 5540.168974653794, 5540.473655002768, 5543.805966791163, 5584.720763961806, 4366.519682834885, 4372.519022907493, 4373.650107991353, 4393.143337049277, 4406.581374769392, 4087.4044981436705, 4320.935185972213, 4321.870343889688, 4398.3842262083335, 4402.537733537981, 4245.490541135068, 4273.252180868336, 4274.829006839723, 4275.444192255002, 4297.183535128332, 4285.7428554286535, 4286.228478873802, 4300.892477688051, 4314.827406903752, 4364.759938203398, 3643.234920666663, 3725.5529336479794, 3730.9440358394645, 3741.4013757798893, 3741.494898188737, 5474.644148130359, 5490.149026900836, 5514.601148500416, 5529.889402211974, 5531.751071201806, 4862.343583616202, 4907.950920490785, 4909.459959404463, 4969.527894849984, 4988.376452943382, 5709.571782116316, 5841.386654401312, 5852.590318677694, 5885.205497257858, 5905.202797622352, 4130.112025914443, 4150.8547200848125, 4158.542560318362, 4163.937540936889, 4166.000159961618, 5835.708214589254, 5993.640381577119, 6037.977277611962, 6075.362086980892, 6091.390860913917, 4193.874183774492, 4198.118395136994, 4198.3702444633545, 4216.789160541961, 4218.978905105455, 4225.64082053029, 4257.23369793434, 4259.97870010648, 4262.6376757975295, 4269.573042695705, 4873.756312184377, 4882.9755851221225, 4894.0, 4932.802687892516, 4950.133726597831, 5606.971965140148, 5703.771849125988, 5870.941290587125, 5873.119032145212, 5876.324222714357, 1451.9056261342978, 1452.7602945514084, 1464.7436698577706, 1475.896687231905, 1476.5644134980207, 873.9781505462287, 906.5920335848895, 917.0279503725939, 924.8104138651561, 927.3554879358916, 4996.701517302009, 5004.624653151028, 5026.673266237683, 5078.238264260391, 5106.897862042812, 5259.263703081571, 5328.973355133199, 5353.625246232804, 5376.650517716336, 5431.2396264522995, 5032.572231360376, 5057.799857062189, 5067.0, 5227.294315267391, 5712.942870571324, 3167.2873603439043, 3190.808551486918, 3264.396086723916, 3265.591801024872, 3271.918202044968, 6143.477804386588, 6302.684865756693, 6306.936930630635, 6314.873702525923, 6342.873142537123, 6121.418465245794, 6134.171886795226, 6152.507799376039, 6157.322694503601, 6232.470240029648, 6233.407826256498, 6243.282022567372, 6264.5301602379095, 6268.404501572434, 6286.119943207955, 5715.77110921154, 5918.674472904032, 5999.820005399671, 6034.909476357946, 6057.7879774207695, 5894.823155305347, 5951.464368206882, 5960.006795447148, 6006.138097189885, 6028.2163318770035, 5946.0, 6176.845578860385, 6178.845528861814, 6182.258129024546, 6191.907121393273, 4122.91754164921, 4171.499420069611, 4184.476940382452, 4198.908283846283, 4201.285781417228, 5781.277340332458, 5811.128330750421, 5973.253343332083, 6045.939540604713, 6101.786437474667, 5769.278840144982, 5777.382332946781, 5800.8259752207505, 5819.679917604572, 5850.473457388855, 5721.8569535761935, 5758.337791153904, 5791.8552036199435, 5800.24596802413, 5827.708614569339, 5612.494875461228, 5632.464915832989, 5728.684922329312, 5728.713564321684, 5764.048931926185, 5877.559183061373, 5880.735366908585, 5885.557493640092, 5896.970515147568, 5900.852478688067, 5700.686462244616, 5702.344230413555, 5735.512481439125, 5786.566007549366, 5817.738201780845], "value": 4390.193527074757, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [745.3105877063715, 769.9864061678293, 800.823818759873, 819.9508029518229, 836.431226765799, 14947.476838310662, 16275.186240687963, 16315.428959986388, 16320.673586528292, 16333.428330008452, 14559.854401455983, 14710.19093949835, 14856.18290993995, 15180.772288415683, 15194.848051519482, 789.1595450844832, 799.4803377804416, 800.2757504458474, 801.0187520287631, 803.5259197073725, 775.3874439193031, 794.5868148562744, 794.6463823598501, 796.0, 796.41861441148, 821.995890020549, 823.9423240373176, 824.1387749801441, 824.9298809601161, 827.0902007791442, 811.2131232704268, 815.7797394703426, 816.0533780814256, 822.7202751064607, 823.6170180865867, 600.0069884341422, 601.0443395001925, 601.1283638723825, 602.2652364115771, 604.6251324178993, 14563.417463301455, 14759.262036898112, 14799.40802367904, 14803.0, 14868.776968345483, 14760.114393136446, 14791.40834366624, 14831.77752333716, 14863.628409289746, 14905.850941490664, 12252.791068580578, 12355.196912200769, 12455.501779928793, 12506.999440044865, 12564.497420103186, 3906.8437262509465, 3919.490466239399, 3997.2405243004027, 4108.4453598764085, 4122.690798190148, 81905.0, 82832.58583707042, 82982.17017829805, 83891.0, 83960.99999999939, 11509.884901151048, 11729.941350293195, 11781.528738850522, 11829.645110646694, 11936.0, 21763.129474821148, 21769.346919592437, 21809.23667671624, 21820.89089554542, 21826.563468730856, 7789.7273595423885, 8321.583920803936, 8726.781830454289, 8825.558722063872, 8854.0, 4456.532064133219, 4726.787294571753, 4741.454732705714, 4958.950410495849, 5024.221245706921, 3475.652434756504, 3556.342076715816, 3563.8574457021946, 3585.713142948558, 3592.1558433768046, 620.3269452643932, 627.9215098112736, 650.9479241660656, 651.7262749645066, 652.6834485274638, 653.4054010850103, 705.5131958948309, 743.171363929215, 758.6775620361325, 781.5740421470313, 10130.797384052277, 10260.897391025994, 10306.278560500694, 10385.740356490996, 10671.626493072705, 593.6141508019822, 613.0742578706097, 624.6002558362652, 716.0011783561902, 744.5681504727245, 4757.976210118927, 4766.952330476651, 4916.434610019822, 4963.975180124076, 4975.626827987915, 64942.675286623264, 119160.0, 120252.3987380075, 121894.39052804856, 123789.0, 103196.0, 103727.0, 104297.47851260695, 105803.0, 107744.0, 88297.99999999872, 89162.0, 92008.0, 92301.0, 92518.0, 9405.43567385959, 9519.666811661558, 9584.520773961134, 9668.323217374716, 9721.659741909281, 37921.81039094787, 48966.51033489762, 51672.48327516827, 52551.737241313545, 53401.73299133635, 69275.65362173358, 69722.0, 75925.62037189779, 76859.0, 80942.19057809346, 11182.776344473228, 11552.6534203974, 11571.826422603835, 11888.048956083665, 11895.821562676394, 13067.934660326637, 13346.532871349456, 13347.466101355836, 13443.327833608477, 13847.79228311556, 13121.278329691577, 14137.575872723835, 14170.504032358818, 14819.851801481847, 14884.702305954037, 13437.798433023709, 13860.861391385957, 13962.232077235443, 14543.563693089225, 14704.485343012942, 14028.929855350658, 14245.786313205102, 14503.419863205354, 14629.853701463275, 14679.339429725474, 11695.590654327058, 11700.35648039366, 11841.28952262867, 12459.190152640049, 12461.0, 10476.69824059637, 11281.09751219884, 12111.0, 12297.508099675913, 12535.811962820382], "value": 7632.70606143979, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1532.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 109.0, 106.0, 112.0, 115.0, 112.0, 111.0, 110.0, 112.0, 115.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 128.0, 158.0, 179.0, 129.0, 164.0, 156.0, 128.0, 187.0, 140.0], "value": 152.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 163.0, 161.0, 163.0, 171.0, 163.0, 162.0, 165.0, 164.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 160.0, 76.0, 75.0, 75.0, 75.0, 161.0, 75.0], "value": 92.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 147.0, 85.0, 86.0, 86.0, 132.0, 86.0, 85.0, 152.0], "value": 102.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 119.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 148.0, 148.0, 149.0, 148.0, 147.0, 147.0, 148.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 102.0, 96.0, 96.0, 95.0, 95.0, 97.0, 96.0, 95.0, 96.0], "value": 96.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 54.0, 52.0, 54.0, 51.0, 52.0, 58.0, 54.0, 56.0], "value": 53.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 63.0, 62.0, 63.0, 62.0, 62.0, 63.0, 63.0], "value": 62.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 78.0, 80.0, 79.0, 80.0, 83.0, 81.0, 80.0, 94.0, 79.0], "value": 81.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 131.0, 124.0, 125.0, 134.0, 123.0, 129.0, 124.0, 124.0, 124.0], "value": 127.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 162.0, 155.0, 164.0, 164.0, 159.0, 164.0, 161.0, 156.0, 162.0], "value": 160.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 63.0, 62.0, 63.0, 63.0, 62.0, 65.0, 62.0, 63.0], "value": 63.0, "unit": "score"}]}]} 09:12:10 INFO - Return code: 0 09:12:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:12:10 ERROR - # TBPL SUCCESS # 09:12:10 INFO - Running post-action listener: _resource_record_post_action 09:12:10 INFO - ##### 09:12:10 INFO - ##### Finished run-tests step (success) 09:12:10 INFO - ##### 09:12:10 INFO - Running post-run listener: _resource_record_post_run 09:12:10 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 552615936; Read time: 32; Write time: 524816 09:12:10 INFO - TinderboxPrint: CPU usage
13.4% 09:12:10 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 32 09:12:10 INFO - TinderboxPrint: I/O write bytes / time
552,615,936 / 524,816 09:12:10 INFO - TinderboxPrint: CPU idle
8,229.5 (86.6%) 09:12:10 INFO - TinderboxPrint: CPU user
1,220.5 (12.8%) 09:12:10 INFO - TinderboxPrint: Swap in / out
0 / 0 09:12:10 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 179527680; Read time: 0; Write time: 235844 09:12:10 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289226752; Read time: 32; Write time: 226160 09:12:11 INFO - Running post-run listener: _upload_blobber_files 09:12:11 INFO - Blob upload gear active. 09:12:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:12:11 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 09:12:11 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'] 09:12:11 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 09:12:11 INFO - (blobuploader) - INFO - Open directory for files ... 09:12:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:12:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:12:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:12:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:12:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:12:12 INFO - (blobuploader) - INFO - Done attempting. 09:12:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:12:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:12:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:12:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:12:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:12:12 INFO - (blobuploader) - INFO - Done attempting. 09:12:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:12:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:12:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:12:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:12:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:12:16 INFO - (blobuploader) - INFO - Done attempting. 09:12:16 INFO - (blobuploader) - INFO - Iteration through files over. 09:12:16 INFO - Return code: 0 09:12:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:12:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:12:16 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/57ce431ffe38ec0c1335e6d5e0091f160294f6a81c3d69d04d36f49bed5d371fad0fa01c28d7448dbd3d7edce0651402e73291f06572facfd34a6b8477218fa4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/202c780ef6e6d2dd3ebf9b82320dad0df5fab9daba9348bebd5cee4c1004d52b748406e2265fddf5b6954a1fb1ab216613a2b3e20f3b7b4b0afe27c061a4a87b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/17abe620260d82495a4988270448dd958fc0aa2fc3b69ee3ff49af9f0ebe4008f75d3f4d4d4a16570675ba1ca8a6f28dda29d89a1ea7f97633ee457db9027bcb"} 09:12:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:12:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:12:16 INFO - Contents: 09:12:16 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/57ce431ffe38ec0c1335e6d5e0091f160294f6a81c3d69d04d36f49bed5d371fad0fa01c28d7448dbd3d7edce0651402e73291f06572facfd34a6b8477218fa4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/202c780ef6e6d2dd3ebf9b82320dad0df5fab9daba9348bebd5cee4c1004d52b748406e2265fddf5b6954a1fb1ab216613a2b3e20f3b7b4b0afe27c061a4a87b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/17abe620260d82495a4988270448dd958fc0aa2fc3b69ee3ff49af9f0ebe4008f75d3f4d4d4a16570675ba1ca8a6f28dda29d89a1ea7f97633ee457db9027bcb"} 09:12:16 INFO - Running post-run listener: copy_logs_to_upload_dir 09:12:16 INFO - Copying logs to upload dir... 09:12:16 INFO - mkdir: /builds/slave/test/build/upload/logs 09:12:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.786602 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-06-28 09:12:16.892969) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 09:12:16.896703) ========= 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=c6927cf182745ad25b1d38b9000001fe-1467129097.322592-244484951 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/57ce431ffe38ec0c1335e6d5e0091f160294f6a81c3d69d04d36f49bed5d371fad0fa01c28d7448dbd3d7edce0651402e73291f06572facfd34a6b8477218fa4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/202c780ef6e6d2dd3ebf9b82320dad0df5fab9daba9348bebd5cee4c1004d52b748406e2265fddf5b6954a1fb1ab216613a2b3e20f3b7b4b0afe27c061a4a87b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/17abe620260d82495a4988270448dd958fc0aa2fc3b69ee3ff49af9f0ebe4008f75d3f4d4d4a16570675ba1ca8a6f28dda29d89a1ea7f97633ee457db9027bcb"} build_url:https://queue.taskcluster.net/v1/task/cr5F_T4mQL6clQZeJgQLkw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011323 build_url: 'https://queue.taskcluster.net/v1/task/cr5F_T4mQL6clQZeJgQLkw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/57ce431ffe38ec0c1335e6d5e0091f160294f6a81c3d69d04d36f49bed5d371fad0fa01c28d7448dbd3d7edce0651402e73291f06572facfd34a6b8477218fa4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/202c780ef6e6d2dd3ebf9b82320dad0df5fab9daba9348bebd5cee4c1004d52b748406e2265fddf5b6954a1fb1ab216613a2b3e20f3b7b4b0afe27c061a4a87b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/17abe620260d82495a4988270448dd958fc0aa2fc3b69ee3ff49af9f0ebe4008f75d3f4d4d4a16570675ba1ca8a6f28dda29d89a1ea7f97633ee457db9027bcb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 09:12:16.925438) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 09:12:16.925755) ========= 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=c6927cf182745ad25b1d38b9000001fe-1467129097.322592-244484951 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004546 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 09:12:17.010280) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 09:12:17.010594) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 09:12:17.010878) ========= ========= Total master_lag: 0.17 =========