builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-054 starttime: 1466583544.53 results: success (0) buildid: 20160622002201 builduid: ca91bf14d7034b1e9e61c1b839a6aef8 revision: a1746be133dff55de7588c846aaafbc30534b8bd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 01:19:04.531419) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 01:19:04.532061) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 01:19:04.532431) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 01:19:04.548017) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 01:19:04.548429) ========= 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=cbe409c6de289db6ac707de3000001d4-1466583454.983663-1088127833 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-22 01:19:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-06-22 01:19:05 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.112682 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 01:19:04.680982) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 01:19:04.681701) ========= 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=cbe409c6de289db6ac707de3000001d4-1466583454.983663-1088127833 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019819 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 01:19:04.736541) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 01:19:04.737486) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a1746be133dff55de7588c846aaafbc30534b8bd --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 a1746be133dff55de7588c846aaafbc30534b8bd --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=cbe409c6de289db6ac707de3000001d4-1466583454.983663-1088127833 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-22 01:19:05,267 truncating revision to first 12 chars 2016-06-22 01:19:05,267 Setting DEBUG logging. 2016-06-22 01:19:05,267 attempt 1/10 2016-06-22 01:19:05,267 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a1746be133df?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-22 01:19:05,590 unpacking tar archive at: fx-team-a1746be133df/testing/mozharness/ program finished with exit code 0 elapsedTime=0.648459 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 01:19:05.402295) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 01:19:05.402890) ========= script_repo_revision: a1746be133dff55de7588c846aaafbc30534b8bd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 01:19:05.403689) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 01:19:05.404259) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 01:19:05.414881) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-22 01:19:05.415203) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=cbe409c6de289db6ac707de3000001d4-1466583454.983663-1088127833 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:19:06 INFO - MultiFileLogger online at 20160622 01:19:06 in /builds/slave/test 01:19:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 01:19:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:19:06 INFO - {'append_to_log': False, 01:19:06 INFO - 'base_work_dir': '/builds/slave/test', 01:19:06 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 01:19:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:19:06 INFO - 'branch': 'Fx-Team-Non-PGO', 01:19:06 INFO - 'buildbot_json_path': 'buildprops.json', 01:19:06 INFO - 'config_files': ('talos/linux_config.py',), 01:19:06 INFO - 'default_actions': ('clobber', 01:19:06 INFO - 'read-buildbot-config', 01:19:06 INFO - 'download-and-extract', 01:19:06 INFO - 'populate-webroot', 01:19:06 INFO - 'create-virtualenv', 01:19:06 INFO - 'install', 01:19:06 INFO - 'run-tests'), 01:19:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:19:06 INFO - 'download_minidump_stackwalk': True, 01:19:06 INFO - 'download_symbols': 'ondemand', 01:19:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:19:06 INFO - 'tooltool.py': '/tools/tooltool.py', 01:19:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:19:06 INFO - '/tools/misc-python/virtualenv.py')}, 01:19:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:19:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:19:06 INFO - 'installer_path': 'installer.exe', 01:19:06 INFO - 'log_level': 'info', 01:19:06 INFO - 'log_name': 'talos', 01:19:06 INFO - 'log_to_console': True, 01:19:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:19:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:19:06 INFO - 'opt_config_files': (), 01:19:06 INFO - 'pip_index': False, 01:19:06 INFO - 'sps_profile': False, 01:19:06 INFO - 'sps_profile_interval': 0, 01:19:06 INFO - 'suite': 'dromaeojs', 01:19:06 INFO - 'system_bits': '32', 01:19:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:19:06 INFO - 'title': 'talos-linux64-ix-054', 01:19:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:19:06 INFO - 'use_talos_json': True, 01:19:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:19:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:19:06 INFO - 'work_dir': 'build'} 01:19:06 INFO - ##### 01:19:06 INFO - ##### Running clobber step. 01:19:06 INFO - ##### 01:19:06 INFO - Running pre-action listener: _resource_record_pre_action 01:19:06 INFO - Running main action method: clobber 01:19:06 INFO - rmtree: /builds/slave/test/build 01:19:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:19:06 INFO - Running post-action listener: _resource_record_post_action 01:19:06 INFO - ##### 01:19:06 INFO - ##### Finished clobber step (success) 01:19:06 INFO - ##### 01:19:06 INFO - ##### 01:19:06 INFO - ##### Running read-buildbot-config step. 01:19:06 INFO - ##### 01:19:06 INFO - Running pre-action listener: _resource_record_pre_action 01:19:06 INFO - Running main action method: read_buildbot_config 01:19:06 INFO - Using buildbot properties: 01:19:06 INFO - { 01:19:06 INFO - "project": "", 01:19:06 INFO - "product": "firefox", 01:19:06 INFO - "script_repo_revision": "production", 01:19:06 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 01:19:06 INFO - "repository": "", 01:19:06 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 01:19:06 INFO - "buildid": "20160622002201", 01:19:06 INFO - "pgo_build": "False", 01:19:06 INFO - "basedir": "/builds/slave/test", 01:19:06 INFO - "buildnumber": 1769, 01:19:06 INFO - "slavename": "talos-linux64-ix-054", 01:19:06 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:19:06 INFO - "platform": "ubuntu64_hw", 01:19:06 INFO - "scheduler": "tests-fx-team-linux64-talos", 01:19:06 INFO - "branch": "fx-team", 01:19:06 INFO - "repo_path": "integration/fx-team", 01:19:06 INFO - "revision": "a1746be133dff55de7588c846aaafbc30534b8bd", 01:19:06 INFO - "stage_platform": "linux64", 01:19:06 INFO - "builduid": "ca91bf14d7034b1e9e61c1b839a6aef8", 01:19:06 INFO - "slavebuilddir": "test" 01:19:06 INFO - } 01:19:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/EUpwcNOCQtWHgtJJCTTbsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 01:19:06 INFO - Running post-action listener: _resource_record_post_action 01:19:06 INFO - ##### 01:19:06 INFO - ##### Finished read-buildbot-config step (success) 01:19:06 INFO - ##### 01:19:06 INFO - ##### 01:19:06 INFO - ##### Running download-and-extract step. 01:19:06 INFO - ##### 01:19:06 INFO - Running pre-action listener: _resource_record_pre_action 01:19:06 INFO - Running main action method: download_and_extract 01:19:06 INFO - mkdir: /builds/slave/test/build/tests 01:19:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:06 INFO - https://queue.taskcluster.net/v1/task/EUpwcNOCQtWHgtJJCTTbsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:19:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUpwcNOCQtWHgtJJCTTbsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:19:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUpwcNOCQtWHgtJJCTTbsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:19:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUpwcNOCQtWHgtJJCTTbsw/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 01:19:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUpwcNOCQtWHgtJJCTTbsw/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 01:19:07 INFO - Downloaded 1361 bytes. 01:19:07 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:19:07 INFO - Using the following test package requirements: 01:19:07 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:19:07 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:19:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:19:07 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:19:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:19:07 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:19:07 INFO - u'jsshell-linux-x86_64.zip'], 01:19:07 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:19:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:19:07 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:19:07 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:19:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:19:07 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:19:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:19:07 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:19:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:19:07 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:19:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:19:07 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:19: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')]} 01:19:07 INFO - https://queue.taskcluster.net/v1/task/EUpwcNOCQtWHgtJJCTTbsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:19:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUpwcNOCQtWHgtJJCTTbsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:19:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUpwcNOCQtWHgtJJCTTbsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:19:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUpwcNOCQtWHgtJJCTTbsw/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 01:19:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUpwcNOCQtWHgtJJCTTbsw/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 01:19:08 INFO - Downloaded 22701903 bytes. 01:19:08 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'] 01:19:08 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 01:19:09 INFO - Return code: 0 01:19:09 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 01:19:09 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')]} 01:19:09 INFO - https://queue.taskcluster.net/v1/task/EUpwcNOCQtWHgtJJCTTbsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:19:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUpwcNOCQtWHgtJJCTTbsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:19:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUpwcNOCQtWHgtJJCTTbsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:19:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUpwcNOCQtWHgtJJCTTbsw/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 01:19:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUpwcNOCQtWHgtJJCTTbsw/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 01:19:10 INFO - Downloaded 22701903 bytes. 01:19:10 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'] 01:19:10 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 01:19:11 INFO - Return code: 0 01:19:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:11 INFO - https://queue.taskcluster.net/v1/task/EUpwcNOCQtWHgtJJCTTbsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:19:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUpwcNOCQtWHgtJJCTTbsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:19:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUpwcNOCQtWHgtJJCTTbsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:19:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUpwcNOCQtWHgtJJCTTbsw/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 01:19:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUpwcNOCQtWHgtJJCTTbsw/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 01:19:12 INFO - Downloaded 14405384 bytes. 01:19:12 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'] 01:19:12 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 01:19:13 INFO - Return code: 0 01:19:13 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')]} 01:19:13 INFO - https://queue.taskcluster.net/v1/task/EUpwcNOCQtWHgtJJCTTbsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:19:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUpwcNOCQtWHgtJJCTTbsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:19:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUpwcNOCQtWHgtJJCTTbsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:19:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUpwcNOCQtWHgtJJCTTbsw/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 01:19:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EUpwcNOCQtWHgtJJCTTbsw/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 01:19:14 INFO - Downloaded 56243482 bytes. 01:19:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EUpwcNOCQtWHgtJJCTTbsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:19:14 INFO - mkdir: /builds/slave/test/properties 01:19:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:19:14 INFO - Writing to file /builds/slave/test/properties/build_url 01:19:14 INFO - Contents: 01:19:14 INFO - build_url:https://queue.taskcluster.net/v1/task/EUpwcNOCQtWHgtJJCTTbsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:19:15 INFO - Running post-action listener: _resource_record_post_action 01:19:15 INFO - Running post-action listener: set_extra_try_arguments 01:19:15 INFO - ##### 01:19:15 INFO - ##### Finished download-and-extract step (success) 01:19:15 INFO - ##### 01:19:15 INFO - ##### 01:19:15 INFO - ##### Running populate-webroot step. 01:19:15 INFO - ##### 01:19:15 INFO - Running pre-action listener: _resource_record_pre_action 01:19:15 INFO - Running main action method: populate_webroot 01:19:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:19:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:19:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:19:15 INFO - '--tppagecycles', 01:19:15 INFO - '7'], 01:19:15 INFO - 'tests': ['tsvgm']}}, 01:19:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:19:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:19:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:19:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:19:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:19:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:19:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:15 INFO - 'talos_options': ['--disable-e10s'], 01:19:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:19:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:19:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:15 INFO - 'talos_options': ['--disable-e10s'], 01:19:15 INFO - 'tests': ['damp', 'tps']}, 01:19:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:15 INFO - 'tests': ['damp', 'tps']}, 01:19:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:19:15 INFO - 'tests': ['dromaeo_dom']}, 01:19:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:19:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:19:15 INFO - 'tests': ['basic_compositor_video']}, 01:19:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:19:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:19:15 INFO - 'tests': ['a11yr', 01:19:15 INFO - 'ts_paint', 01:19:15 INFO - 'tpaint', 01:19:15 INFO - 'sessionrestore', 01:19:15 INFO - 'sessionrestore_no_auto_restore', 01:19:15 INFO - 'tabpaint']}, 01:19:15 INFO - 'other-e10s': {'tests': ['a11yr', 01:19:15 INFO - 'ts_paint', 01:19:15 INFO - 'tpaint', 01:19:15 INFO - 'sessionrestore', 01:19:15 INFO - 'sessionrestore_no_auto_restore', 01:19:15 INFO - 'tabpaint']}, 01:19:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:19:15 INFO - 'ts_paint', 01:19:15 INFO - 'tpaint', 01:19:15 INFO - 'sessionrestore', 01:19:15 INFO - 'sessionrestore_no_auto_restore', 01:19:15 INFO - 'tabpaint']}, 01:19:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:19:15 INFO - 'ts_paint', 01:19:15 INFO - 'tpaint', 01:19:15 INFO - 'sessionrestore', 01:19:15 INFO - 'sessionrestore_no_auto_restore', 01:19:15 INFO - 'tabpaint']}, 01:19:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:19:15 INFO - 'tests': ['a11yr', 01:19:15 INFO - 'ts_paint', 01:19:15 INFO - 'tpaint', 01:19:15 INFO - 'sessionrestore', 01:19:15 INFO - 'sessionrestore_no_auto_restore', 01:19:15 INFO - 'tabpaint']}, 01:19:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:19:15 INFO - 'tests': ['a11yr', 01:19:15 INFO - 'ts_paint', 01:19:15 INFO - 'tpaint', 01:19:15 INFO - 'sessionrestore', 01:19:15 INFO - 'sessionrestore_no_auto_restore', 01:19:15 INFO - 'tabpaint']}, 01:19:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:19:15 INFO - 'tests': ['tsvgx', 01:19:15 INFO - 'tsvgr_opacity', 01:19:15 INFO - 'tart', 01:19:15 INFO - 'tscrollx', 01:19:15 INFO - 'cart']}, 01:19:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:19:15 INFO - 'tsvgr_opacity', 01:19:15 INFO - 'tart', 01:19:15 INFO - 'tscrollx', 01:19:15 INFO - 'cart']}, 01:19:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:15 INFO - 'talos_options': ['--disable-e10s'], 01:19:15 INFO - 'tests': ['tp5o']}, 01:19:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:15 INFO - 'tests': ['tp5o']}, 01:19:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:15 INFO - 'talos_options': ['--disable-e10s', 01:19:15 INFO - '--xperf_path', 01:19:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:19:15 INFO - 'tests': ['tp5n']}, 01:19:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:19:15 INFO - 'talos_options': ['--xperf_path', 01:19:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:19:15 INFO - 'tests': ['tp5n']}}, 01:19:15 INFO - 'talos.zip': {'path': '', 01:19:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:19:15 INFO - Running post-action listener: _resource_record_post_action 01:19:15 INFO - ##### 01:19:15 INFO - ##### Finished populate-webroot step (success) 01:19:15 INFO - ##### 01:19:15 INFO - ##### 01:19:15 INFO - ##### Running create-virtualenv step. 01:19:15 INFO - ##### 01:19:15 INFO - Running pre-action listener: _resource_record_pre_action 01:19:15 INFO - Running main action method: create_virtualenv 01:19:15 INFO - Creating virtualenv /builds/slave/test/build/venv 01:19:15 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 01:19:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:19:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:19:15 INFO - Using real prefix '/usr' 01:19:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:19:15 INFO - Installing distribute.............................................................................................................................................................................................done. 01:19:17 INFO - Installing pip.................done. 01:19:17 INFO - Return code: 0 01:19:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:19:17 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')]} 01:19:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:17 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')]} 01:19:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:17 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 0x7f1552852f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1457350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e61c0>, '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 0x14e70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e7550>, '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': 'cbe409c6de289db6ac707de3000001d4-1466583454.983663-1088127833', '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 01:19:17 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 01:19:17 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 01:19:17 INFO - Using env: {'DISPLAY': ':0', 01:19:17 INFO - 'HOME': '/home/cltbld', 01:19:17 INFO - 'LANG': 'en_US.UTF-8', 01:19:17 INFO - 'LANGUAGE': 'en_US:en', 01:19:17 INFO - 'LOGNAME': 'cltbld', 01:19:17 INFO - 'MAIL': '/var/mail/cltbld', 01:19:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:17 INFO - 'MOZ_NO_REMOTE': '1', 01:19:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:17 INFO - 'NO_EM_RESTART': '1', 01:19:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:17 INFO - 'PWD': '/builds/slave/test', 01:19:17 INFO - 'SHELL': '/bin/bash', 01:19:17 INFO - 'SHLVL': '1', 01:19:17 INFO - 'TERM': 'linux', 01:19:17 INFO - 'TMOUT': '86400', 01:19:17 INFO - 'USER': 'cltbld', 01:19:17 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1466583454.983663-1088127833', 01:19:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:17 INFO - '_': '/tools/buildbot/bin/python'} 01:19:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:18 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 01:19:18 INFO - Cleaning up... 01:19:18 INFO - Return code: 0 01:19:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:19:18 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')]} 01:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:18 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')]} 01:19:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:18 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 0x7f1552852f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1457350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e61c0>, '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 0x14e70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e7550>, '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': 'cbe409c6de289db6ac707de3000001d4-1466583454.983663-1088127833', '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 01:19:18 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 01:19:18 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 01:19:18 INFO - Using env: {'DISPLAY': ':0', 01:19:18 INFO - 'HOME': '/home/cltbld', 01:19:18 INFO - 'LANG': 'en_US.UTF-8', 01:19:18 INFO - 'LANGUAGE': 'en_US:en', 01:19:18 INFO - 'LOGNAME': 'cltbld', 01:19:18 INFO - 'MAIL': '/var/mail/cltbld', 01:19:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:18 INFO - 'MOZ_NO_REMOTE': '1', 01:19:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:18 INFO - 'NO_EM_RESTART': '1', 01:19:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:18 INFO - 'PWD': '/builds/slave/test', 01:19:18 INFO - 'SHELL': '/bin/bash', 01:19:18 INFO - 'SHLVL': '1', 01:19:18 INFO - 'TERM': 'linux', 01:19:18 INFO - 'TMOUT': '86400', 01:19:18 INFO - 'USER': 'cltbld', 01:19:18 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1466583454.983663-1088127833', 01:19:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:18 INFO - '_': '/tools/buildbot/bin/python'} 01:19:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:18 INFO - Downloading/unpacking psutil>=3.1.1 01:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:19:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:19:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:19:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:19:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:19:20 INFO - Installing collected packages: psutil 01:19:20 INFO - Running setup.py install for psutil 01:19:20 INFO - building 'psutil._psutil_linux' extension 01:19:20 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 01:19:20 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 01:19:20 INFO - building 'psutil._psutil_posix' extension 01:19:20 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 01:19:20 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 01:19:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:19:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:19:20 INFO - Successfully installed psutil 01:19:20 INFO - Cleaning up... 01:19:20 INFO - Return code: 0 01:19:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:19:20 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')]} 01:19:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:20 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')]} 01:19:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:20 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 0x7f1552852f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1457350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e61c0>, '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 0x14e70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e7550>, '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': 'cbe409c6de289db6ac707de3000001d4-1466583454.983663-1088127833', '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 01:19:20 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 01:19:20 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 01:19:20 INFO - Using env: {'DISPLAY': ':0', 01:19:20 INFO - 'HOME': '/home/cltbld', 01:19:20 INFO - 'LANG': 'en_US.UTF-8', 01:19:20 INFO - 'LANGUAGE': 'en_US:en', 01:19:20 INFO - 'LOGNAME': 'cltbld', 01:19:20 INFO - 'MAIL': '/var/mail/cltbld', 01:19:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:20 INFO - 'MOZ_NO_REMOTE': '1', 01:19:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:20 INFO - 'NO_EM_RESTART': '1', 01:19:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:20 INFO - 'PWD': '/builds/slave/test', 01:19:20 INFO - 'SHELL': '/bin/bash', 01:19:20 INFO - 'SHLVL': '1', 01:19:20 INFO - 'TERM': 'linux', 01:19:20 INFO - 'TMOUT': '86400', 01:19:20 INFO - 'USER': 'cltbld', 01:19:20 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1466583454.983663-1088127833', 01:19:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:20 INFO - '_': '/tools/buildbot/bin/python'} 01:19:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:19:21 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 01:19:21 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 01:19:21 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 01:19:21 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 01:19:21 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 01:19:21 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 01:19:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:19:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:19:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:19:23 INFO - Installing collected packages: mozsystemmonitor 01:19:23 INFO - Running setup.py install for mozsystemmonitor 01:19:23 INFO - Successfully installed mozsystemmonitor 01:19:23 INFO - Cleaning up... 01:19:23 INFO - Return code: 0 01:19:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:19:23 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')]} 01:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:23 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')]} 01:19:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:23 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 0x7f1552852f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1457350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e61c0>, '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 0x14e70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e7550>, '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': 'cbe409c6de289db6ac707de3000001d4-1466583454.983663-1088127833', '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 01:19:23 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 01:19:23 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 01:19:23 INFO - Using env: {'DISPLAY': ':0', 01:19:23 INFO - 'HOME': '/home/cltbld', 01:19:23 INFO - 'LANG': 'en_US.UTF-8', 01:19:23 INFO - 'LANGUAGE': 'en_US:en', 01:19:23 INFO - 'LOGNAME': 'cltbld', 01:19:23 INFO - 'MAIL': '/var/mail/cltbld', 01:19:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:23 INFO - 'MOZ_NO_REMOTE': '1', 01:19:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:23 INFO - 'NO_EM_RESTART': '1', 01:19:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:23 INFO - 'PWD': '/builds/slave/test', 01:19:23 INFO - 'SHELL': '/bin/bash', 01:19:23 INFO - 'SHLVL': '1', 01:19:23 INFO - 'TERM': 'linux', 01:19:23 INFO - 'TMOUT': '86400', 01:19:23 INFO - 'USER': 'cltbld', 01:19:23 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1466583454.983663-1088127833', 01:19:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:23 INFO - '_': '/tools/buildbot/bin/python'} 01:19:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:23 INFO - Downloading/unpacking jsonschema==2.5.1 01:19:23 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 01:19:23 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 01:19:23 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 01:19:23 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 01:19:23 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 01:19:23 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 01:19:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:19:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:19:25 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 01:19:25 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 01:19:25 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 01:19:25 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 01:19:25 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 01:19:25 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 01:19:25 INFO - Downloading functools32-3.2.3-2.tar.gz 01:19:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:19:25 INFO - warning: no files found matching '*.txt' 01:19:25 INFO - no previously-included directories found matching 'build' 01:19:25 INFO - no previously-included directories found matching 'dist' 01:19:25 INFO - no previously-included directories found matching '.git*' 01:19:25 INFO - Installing collected packages: jsonschema, functools32 01:19:25 INFO - Running setup.py install for functools32 01:19:25 INFO - warning: no files found matching '*.txt' 01:19:25 INFO - no previously-included directories found matching 'build' 01:19:25 INFO - no previously-included directories found matching 'dist' 01:19:25 INFO - no previously-included directories found matching '.git*' 01:19:25 INFO - Successfully installed jsonschema functools32 01:19:25 INFO - Cleaning up... 01:19:25 INFO - Return code: 0 01:19:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:19:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:25 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 0x7f1552852f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1457350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e61c0>, '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 0x14e70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e7550>, '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': 'cbe409c6de289db6ac707de3000001d4-1466583454.983663-1088127833', '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 01:19:25 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 01:19:25 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 01:19:25 INFO - Using env: {'DISPLAY': ':0', 01:19:25 INFO - 'HOME': '/home/cltbld', 01:19:25 INFO - 'LANG': 'en_US.UTF-8', 01:19:25 INFO - 'LANGUAGE': 'en_US:en', 01:19:25 INFO - 'LOGNAME': 'cltbld', 01:19:25 INFO - 'MAIL': '/var/mail/cltbld', 01:19:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:25 INFO - 'MOZ_NO_REMOTE': '1', 01:19:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:25 INFO - 'NO_EM_RESTART': '1', 01:19:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:25 INFO - 'PWD': '/builds/slave/test', 01:19:25 INFO - 'SHELL': '/bin/bash', 01:19:25 INFO - 'SHLVL': '1', 01:19:25 INFO - 'TERM': 'linux', 01:19:25 INFO - 'TMOUT': '86400', 01:19:25 INFO - 'USER': 'cltbld', 01:19:25 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1466583454.983663-1088127833', 01:19:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:25 INFO - '_': '/tools/buildbot/bin/python'} 01:19:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:26 INFO - Downloading/unpacking blobuploader==1.2.4 01:19:26 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 01:19:26 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 01:19:26 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 01:19:26 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 01:19:26 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 01:19:26 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 01:19:27 INFO - Downloading blobuploader-1.2.4.tar.gz 01:19:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:19:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:19:28 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 01:19:28 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 01:19:28 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 01:19:28 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 01:19:28 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 01:19:28 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 01:19:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:19:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:19:28 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 01:19:28 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 01:19:28 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 01:19:28 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 01:19:28 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 01:19:28 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 01:19:28 INFO - Downloading docopt-0.6.1.tar.gz 01:19:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:19:28 INFO - Installing collected packages: blobuploader, requests, docopt 01:19:28 INFO - Running setup.py install for blobuploader 01:19:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:19:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:19:28 INFO - Running setup.py install for requests 01:19:29 INFO - Running setup.py install for docopt 01:19:29 INFO - Successfully installed blobuploader requests docopt 01:19:29 INFO - Cleaning up... 01:19:29 INFO - Return code: 0 01:19:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:19:29 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')]} 01:19:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:29 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')]} 01:19:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:29 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 0x7f1552852f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1457350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e61c0>, '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 0x14e70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e7550>, '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': 'cbe409c6de289db6ac707de3000001d4-1466583454.983663-1088127833', '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 01:19:29 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 01:19:29 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 01:19:29 INFO - Using env: {'DISPLAY': ':0', 01:19:29 INFO - 'HOME': '/home/cltbld', 01:19:29 INFO - 'LANG': 'en_US.UTF-8', 01:19:29 INFO - 'LANGUAGE': 'en_US:en', 01:19:29 INFO - 'LOGNAME': 'cltbld', 01:19:29 INFO - 'MAIL': '/var/mail/cltbld', 01:19:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:29 INFO - 'MOZ_NO_REMOTE': '1', 01:19:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:29 INFO - 'NO_EM_RESTART': '1', 01:19:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:29 INFO - 'PWD': '/builds/slave/test', 01:19:29 INFO - 'SHELL': '/bin/bash', 01:19:29 INFO - 'SHLVL': '1', 01:19:29 INFO - 'TERM': 'linux', 01:19:29 INFO - 'TMOUT': '86400', 01:19:29 INFO - 'USER': 'cltbld', 01:19:29 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1466583454.983663-1088127833', 01:19:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:29 INFO - '_': '/tools/buildbot/bin/python'} 01:19:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:19:29 INFO - Running setup.py (path:/tmp/pip-0Puhtg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:19:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:19:29 INFO - Running setup.py (path:/tmp/pip-koDtPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:19:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:19:29 INFO - Running setup.py (path:/tmp/pip-T4SPls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:19:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:19:29 INFO - Running setup.py (path:/tmp/pip-Puojbu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:19:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:19:29 INFO - Running setup.py (path:/tmp/pip-NUhWV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:19:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:19:29 INFO - Running setup.py (path:/tmp/pip-E52o5S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:19:30 INFO - Running setup.py (path:/tmp/pip-RSPcib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:19:30 INFO - Running setup.py (path:/tmp/pip-91IqVZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:19:30 INFO - Running setup.py (path:/tmp/pip-xYcJJt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:19:30 INFO - Running setup.py (path:/tmp/pip-Ci47QD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:19:30 INFO - Running setup.py (path:/tmp/pip-z5jTRn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:19:30 INFO - Running setup.py (path:/tmp/pip-tz2o2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:19:30 INFO - Running setup.py (path:/tmp/pip-tjJMIt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:19:30 INFO - Running setup.py (path:/tmp/pip-Bo1WWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:19:30 INFO - Running setup.py (path:/tmp/pip-uxmOqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:19:30 INFO - Running setup.py (path:/tmp/pip-l1DfTr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:19:30 INFO - Running setup.py (path:/tmp/pip-N1724f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:19:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:19:30 INFO - Running setup.py install for manifestparser 01:19:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:19:30 INFO - Running setup.py install for mozcrash 01:19:31 INFO - Running setup.py install for mozdebug 01:19:31 INFO - Running setup.py install for mozdevice 01:19:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:19:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:19:31 INFO - Running setup.py install for mozfile 01:19:31 INFO - Running setup.py install for mozhttpd 01:19:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:19:31 INFO - Running setup.py install for mozinfo 01:19:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:19:31 INFO - Running setup.py install for mozInstall 01:19:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:19:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:19:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:19:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:19:31 INFO - Running setup.py install for mozleak 01:19:31 INFO - Running setup.py install for mozlog 01:19:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:19:31 INFO - Running setup.py install for moznetwork 01:19:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:19:31 INFO - Running setup.py install for mozprocess 01:19:32 INFO - Running setup.py install for mozprofile 01:19:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:19:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:19:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:19:32 INFO - Running setup.py install for mozrunner 01:19:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:19:32 INFO - Running setup.py install for mozscreenshot 01:19:32 INFO - Running setup.py install for moztest 01:19:32 INFO - Running setup.py install for mozversion 01:19:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:19:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:19:32 INFO - Cleaning up... 01:19:32 INFO - Return code: 0 01:19:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:19:32 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')]} 01:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:32 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')]} 01:19:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:32 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 0x7f1552852f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1457350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e61c0>, '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 0x14e70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e7550>, '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': 'cbe409c6de289db6ac707de3000001d4-1466583454.983663-1088127833', '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 01:19:32 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 01:19:32 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 01:19:32 INFO - Using env: {'DISPLAY': ':0', 01:19:32 INFO - 'HOME': '/home/cltbld', 01:19:32 INFO - 'LANG': 'en_US.UTF-8', 01:19:32 INFO - 'LANGUAGE': 'en_US:en', 01:19:32 INFO - 'LOGNAME': 'cltbld', 01:19:32 INFO - 'MAIL': '/var/mail/cltbld', 01:19:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:32 INFO - 'MOZ_NO_REMOTE': '1', 01:19:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:32 INFO - 'NO_EM_RESTART': '1', 01:19:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:32 INFO - 'PWD': '/builds/slave/test', 01:19:32 INFO - 'SHELL': '/bin/bash', 01:19:32 INFO - 'SHLVL': '1', 01:19:32 INFO - 'TERM': 'linux', 01:19:32 INFO - 'TMOUT': '86400', 01:19:32 INFO - 'USER': 'cltbld', 01:19:32 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1466583454.983663-1088127833', 01:19:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:32 INFO - '_': '/tools/buildbot/bin/python'} 01:19:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:19:32 INFO - Running setup.py (path:/tmp/pip-JHcHrw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:19:32 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)) 01:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:19:32 INFO - Running setup.py (path:/tmp/pip-ZycZVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:19:32 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)) 01:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:19:32 INFO - Running setup.py (path:/tmp/pip-yZrOi6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:19:33 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)) 01:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:19:33 INFO - Running setup.py (path:/tmp/pip-M67kw4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:19:33 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)) 01:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:19:33 INFO - Running setup.py (path:/tmp/pip-rJJ2pc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:19:33 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)) 01:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:19:33 INFO - Running setup.py (path:/tmp/pip-k2yXrW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:19:33 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)) 01:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:19:33 INFO - Running setup.py (path:/tmp/pip-qiWXuZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:19:33 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)) 01:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:19:33 INFO - Running setup.py (path:/tmp/pip-3HSC5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:19:33 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)) 01:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:19:33 INFO - Running setup.py (path:/tmp/pip-wZbPvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:19:33 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)) 01:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:19:33 INFO - Running setup.py (path:/tmp/pip-yWpkRF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:19:33 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)) 01:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:19:33 INFO - Running setup.py (path:/tmp/pip-L5jpEK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:19:33 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)) 01:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:19:33 INFO - Running setup.py (path:/tmp/pip-A37XFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:19:33 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)) 01:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:19:33 INFO - Running setup.py (path:/tmp/pip-KpyBjA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:19:33 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)) 01:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:19:33 INFO - Running setup.py (path:/tmp/pip-Zm_GRr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:19:33 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)) 01:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:19:33 INFO - Running setup.py (path:/tmp/pip-ekPDX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:19:33 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)) 01:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:19:33 INFO - Running setup.py (path:/tmp/pip-jPUSQ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:19:33 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)) 01:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:19:33 INFO - Running setup.py (path:/tmp/pip-DC08o3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:19:34 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)) 01:19:34 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)) 01:19:34 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)) 01:19:34 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)) 01:19:34 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)) 01:19:34 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)) 01:19:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:19:34 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 01:19:34 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 01:19:34 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 01:19:34 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 01:19:34 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 01:19:34 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 01:19:36 INFO - Downloading blessings-1.6.tar.gz 01:19:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:19:36 INFO - Installing collected packages: blessings 01:19:36 INFO - Running setup.py install for blessings 01:19:36 INFO - Successfully installed blessings 01:19:36 INFO - Cleaning up... 01:19:36 INFO - Return code: 0 01:19:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:19:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:19:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:19:36 INFO - Reading from file tmpfile_stdout 01:19:36 INFO - Current package versions: 01:19:36 INFO - argparse == 1.2.1 01:19:36 INFO - blessings == 1.6 01:19:36 INFO - blobuploader == 1.2.4 01:19:36 INFO - docopt == 0.6.1 01:19:36 INFO - functools32 == 3.2.3-2 01:19:36 INFO - jsonschema == 2.5.1 01:19:36 INFO - manifestparser == 1.1 01:19:36 INFO - mozInstall == 1.12 01:19:36 INFO - mozcrash == 0.17 01:19:36 INFO - mozdebug == 0.1 01:19:36 INFO - mozdevice == 0.48 01:19:36 INFO - mozfile == 1.2 01:19:36 INFO - mozhttpd == 0.7 01:19:36 INFO - mozinfo == 0.9 01:19:36 INFO - mozleak == 0.1 01:19:36 INFO - mozlog == 3.2 01:19:36 INFO - moznetwork == 0.27 01:19:36 INFO - mozprocess == 0.22 01:19:36 INFO - mozprofile == 0.28 01:19:36 INFO - mozrunner == 6.11 01:19:36 INFO - mozscreenshot == 0.1 01:19:36 INFO - mozsystemmonitor == 0.3 01:19:36 INFO - moztest == 0.7 01:19:36 INFO - mozversion == 1.4 01:19:36 INFO - psutil == 3.1.1 01:19:36 INFO - requests == 1.2.3 01:19:36 INFO - wsgiref == 0.1.2 01:19:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:19:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:36 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 0x7f1552852f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1457350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e61c0>, '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 0x14e70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e7550>, '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': 'cbe409c6de289db6ac707de3000001d4-1466583454.983663-1088127833', '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 01:19:36 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 01:19:36 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 01:19:36 INFO - Using env: {'DISPLAY': ':0', 01:19:36 INFO - 'HOME': '/home/cltbld', 01:19:36 INFO - 'LANG': 'en_US.UTF-8', 01:19:36 INFO - 'LANGUAGE': 'en_US:en', 01:19:36 INFO - 'LOGNAME': 'cltbld', 01:19:36 INFO - 'MAIL': '/var/mail/cltbld', 01:19:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:36 INFO - 'MOZ_NO_REMOTE': '1', 01:19:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:36 INFO - 'NO_EM_RESTART': '1', 01:19:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:36 INFO - 'PWD': '/builds/slave/test', 01:19:36 INFO - 'SHELL': '/bin/bash', 01:19:36 INFO - 'SHLVL': '1', 01:19:36 INFO - 'TERM': 'linux', 01:19:36 INFO - 'TMOUT': '86400', 01:19:36 INFO - 'USER': 'cltbld', 01:19:36 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1466583454.983663-1088127833', 01:19:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:36 INFO - '_': '/tools/buildbot/bin/python'} 01:19:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:36 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)) 01:19:36 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)) 01:19:36 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)) 01:19:36 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)) 01:19:36 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)) 01:19:36 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)) 01:19:36 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)) 01:19:36 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)) 01:19:36 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)) 01:19:36 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)) 01:19:36 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)) 01:19:36 INFO - Cleaning up... 01:19:36 INFO - Return code: 0 01:19:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:19:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:36 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 0x7f1552852f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1457350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e61c0>, '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 0x14e70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e7550>, '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': 'cbe409c6de289db6ac707de3000001d4-1466583454.983663-1088127833', '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 01:19:36 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 01:19:36 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 01:19:36 INFO - Using env: {'DISPLAY': ':0', 01:19:36 INFO - 'HOME': '/home/cltbld', 01:19:36 INFO - 'LANG': 'en_US.UTF-8', 01:19:36 INFO - 'LANGUAGE': 'en_US:en', 01:19:36 INFO - 'LOGNAME': 'cltbld', 01:19:36 INFO - 'MAIL': '/var/mail/cltbld', 01:19:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:36 INFO - 'MOZ_NO_REMOTE': '1', 01:19:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:36 INFO - 'NO_EM_RESTART': '1', 01:19:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:36 INFO - 'PWD': '/builds/slave/test', 01:19:36 INFO - 'SHELL': '/bin/bash', 01:19:36 INFO - 'SHLVL': '1', 01:19:36 INFO - 'TERM': 'linux', 01:19:36 INFO - 'TMOUT': '86400', 01:19:36 INFO - 'USER': 'cltbld', 01:19:36 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1466583454.983663-1088127833', 01:19:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:36 INFO - '_': '/tools/buildbot/bin/python'} 01:19:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:19:36 INFO - Cleaning up... 01:19:36 INFO - Return code: 0 01:19:36 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:19:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:19:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:19:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:19:36 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 0x7f1552852f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1457350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e61c0>, '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 0x14e70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e7550>, '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': 'cbe409c6de289db6ac707de3000001d4-1466583454.983663-1088127833', '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 01:19:36 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 01:19:36 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 01:19:36 INFO - Using env: {'DISPLAY': ':0', 01:19:36 INFO - 'HOME': '/home/cltbld', 01:19:36 INFO - 'LANG': 'en_US.UTF-8', 01:19:36 INFO - 'LANGUAGE': 'en_US:en', 01:19:36 INFO - 'LOGNAME': 'cltbld', 01:19:36 INFO - 'MAIL': '/var/mail/cltbld', 01:19:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:36 INFO - 'MOZ_NO_REMOTE': '1', 01:19:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:36 INFO - 'NO_EM_RESTART': '1', 01:19:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:36 INFO - 'PWD': '/builds/slave/test', 01:19:36 INFO - 'SHELL': '/bin/bash', 01:19:36 INFO - 'SHLVL': '1', 01:19:36 INFO - 'TERM': 'linux', 01:19:36 INFO - 'TMOUT': '86400', 01:19:36 INFO - 'USER': 'cltbld', 01:19:36 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1466583454.983663-1088127833', 01:19:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:36 INFO - '_': '/tools/buildbot/bin/python'} 01:19:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:19:37 INFO - Downloading/unpacking flake8 01:19:37 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 01:19:37 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 01:19:37 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 01:19:37 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 01:19:37 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 01:19:37 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 01:19:39 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:19:39 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:19:39 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 01:19:39 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 01:19:39 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 01:19:39 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 01:19:39 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 01:19:39 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 01:19:39 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:19:39 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:19:39 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 01:19:39 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 01:19:39 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 01:19:39 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 01:19:39 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 01:19:39 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 01:19:39 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:19:39 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 01:19:39 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 01:19:39 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 01:19:39 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 01:19:39 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 01:19:39 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 01:19:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:19:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:19:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:19:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:19:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:19:39 INFO - no previously-included directories found matching 'docs/_build' 01:19:39 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:19:39 INFO - Running setup.py install for pep8 01:19:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:19:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:19:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:19:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:19:39 INFO - no previously-included directories found matching 'docs/_build' 01:19:39 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:19:39 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:19:39 INFO - Cleaning up... 01:19:40 INFO - Return code: 0 01:19:40 INFO - Running post-action listener: _resource_record_post_action 01:19:40 INFO - Running post-action listener: _start_resource_monitoring 01:19:40 INFO - Starting resource monitoring. 01:19:40 INFO - ##### 01:19:40 INFO - ##### Finished create-virtualenv step (success) 01:19:40 INFO - ##### 01:19:40 INFO - ##### 01:19:40 INFO - ##### Running install step. 01:19:40 INFO - ##### 01:19:40 INFO - Running pre-action listener: _resource_record_pre_action 01:19:40 INFO - Running main action method: install 01:19:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:19:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:19:40 INFO - Reading from file tmpfile_stdout 01:19:40 INFO - Detecting whether we're running mozinstall >=1.0... 01:19:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:19:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:19:40 INFO - Reading from file tmpfile_stdout 01:19:40 INFO - Output received: 01:19:40 INFO - Usage: mozinstall [options] installer 01:19:40 INFO - Options: 01:19:40 INFO - -h, --help show this help message and exit 01:19:40 INFO - -d DEST, --destination=DEST 01:19:40 INFO - Directory to install application into. [default: 01:19:40 INFO - "/builds/slave/test"] 01:19:40 INFO - --app=APP Application being installed. [default: firefox] 01:19:40 INFO - mkdir: /builds/slave/test/build/application 01:19:40 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'] 01:19:40 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 01:19:56 INFO - Reading from file tmpfile_stdout 01:19:56 INFO - Output received: 01:19:56 INFO - /builds/slave/test/build/application/firefox/firefox 01:19:56 INFO - Running post-action listener: _resource_record_post_action 01:19:56 INFO - ##### 01:19:56 INFO - ##### Finished install step (success) 01:19:56 INFO - ##### 01:19:56 INFO - ##### 01:19:56 INFO - ##### Running run-tests step. 01:19:56 INFO - ##### 01:19:56 INFO - Running pre-action listener: _resource_record_pre_action 01:19:56 INFO - Running main action method: run_tests 01:19:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:19:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:19:56 INFO - Python 2.7.3 01:19:56 INFO - Return code: 0 01:19:56 INFO - grabbing minidump binary from tooltool 01:19:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:19:56 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 0x14e61c0>, '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 0x14e70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e7550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:19:56 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 01:19:56 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 01:19:56 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 01:19:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:19:56 INFO - Return code: 0 01:19:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:19:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:19:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:19:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:19:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:19:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:19:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:19:57 INFO - Return code: 0 01:19:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EUpwcNOCQtWHgtJJCTTbsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 01:19:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EUpwcNOCQtWHgtJJCTTbsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 01:19:57 INFO - Using env: {'DISPLAY': ':0', 01:19:57 INFO - 'HOME': '/home/cltbld', 01:19:57 INFO - 'LANG': 'en_US.UTF-8', 01:19:57 INFO - 'LANGUAGE': 'en_US:en', 01:19:57 INFO - 'LOGNAME': 'cltbld', 01:19:57 INFO - 'MAIL': '/var/mail/cltbld', 01:19:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:19:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:19:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:19:57 INFO - 'MOZ_NO_REMOTE': '1', 01:19:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:19:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:19:57 INFO - 'NO_EM_RESTART': '1', 01:19:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:19:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:19:57 INFO - 'PWD': '/builds/slave/test', 01:19:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:19:57 INFO - 'SHELL': '/bin/bash', 01:19:57 INFO - 'SHLVL': '1', 01:19:57 INFO - 'TERM': 'linux', 01:19:57 INFO - 'TMOUT': '86400', 01:19:57 INFO - 'USER': 'cltbld', 01:19:57 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1466583454.983663-1088127833', 01:19:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:19:57 INFO - '_': '/tools/buildbot/bin/python'} 01:19:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EUpwcNOCQtWHgtJJCTTbsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 01:19:57 INFO - mozversion application_buildid: 20160622002201 01:19:57 INFO - mozversion application_changeset: a1746be133dff55de7588c846aaafbc30534b8bd 01:19:57 INFO - mozversion application_display_name: Nightly 01:19:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:19:57 INFO - mozversion application_name: Firefox 01:19:57 INFO - mozversion application_remotingname: firefox 01:19:57 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:19:57 INFO - mozversion application_vendor: Mozilla 01:19:57 INFO - mozversion application_version: 50.0a1 01:19:57 INFO - mozversion platform_buildid: 20160622002201 01:19:57 INFO - mozversion platform_changeset: a1746be133dff55de7588c846aaafbc30534b8bd 01:19:57 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:19:57 INFO - mozversion platform_version: 50.0a1 01:19:57 INFO - using testdate: 1466583597 01:19:57 INFO - actual date: 1466583597 01:19:57 INFO - starting webserver on 'localhost:35593' 01:19:57 INFO - SUITE-START | Running 2 tests 01:19:57 INFO - TEST-START | dromaeo_css 01:19:57 INFO - operating with platform_type : linux_ 01:19:57 INFO - Initialising browser for dromaeo_css test... 01:19:57 INFO - TEST-INFO | started process 18986 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWswQhs/profile http://localhost:35593/getInfo.html) 01:20:02 INFO - PROCESS | 18986 | __metrics Screen width/height:1600/1200 01:20:02 INFO - PROCESS | 18986 | colorDepth:24 01:20:02 INFO - PROCESS | 18986 | Browser inner width/height: 1024/697 01:20:02 INFO - PROCESS | 18986 | __metrics 01:20:03 INFO - PROCESS | 18986 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:20:04 INFO - TEST-INFO | 18986: exit 0 01:20:04 INFO - Browser initialized. 01:20:04 INFO - Running cycle 1/1 for dromaeo_css test... 01:20:04 INFO - TEST-INFO | started process 19066 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWswQhs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:20:16 INFO - PROCESS | 19066 | RSS: Main: 175009792 01:20:16 INFO - PROCESS | 19066 | 01:21:07 INFO - PROCESS | 19066 | 1466583667643 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] 01:23:20 INFO - PROCESS | 19066 | Cycle 1(1): loaded http://localhost:35593/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35593/tests/dromaeo/cssquery-ext.html) 01:23:21 INFO - PROCESS | 19066 | RSS: Main: 266747904 01:23:21 INFO - PROCESS | 19066 | 01:26:24 INFO - PROCESS | 19066 | Cycle 1(1): loaded http://localhost:35593/tests/dromaeo/cssquery-ext.html (next: http://localhost:35593/tests/dromaeo/cssquery-jquery.html) 01:26:24 INFO - PROCESS | 19066 | RSS: Main: 259911680 01:26:24 INFO - PROCESS | 19066 | 01:29:27 INFO - PROCESS | 19066 | Cycle 1(1): loaded http://localhost:35593/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35593/tests/dromaeo/cssquery-mootools.html) 01:29:27 INFO - PROCESS | 19066 | RSS: Main: 265568256 01:29:27 INFO - PROCESS | 19066 | 01:32:30 INFO - PROCESS | 19066 | Cycle 1(1): loaded http://localhost:35593/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35593/tests/dromaeo/cssquery-prototype.html) 01:32:30 INFO - PROCESS | 19066 | RSS: Main: 251686912 01:32:30 INFO - PROCESS | 19066 | 01:35:33 INFO - PROCESS | 19066 | Cycle 1(1): loaded http://localhost:35593/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35593/tests/dromaeo/cssquery-yui.html) 01:35:34 INFO - PROCESS | 19066 | RSS: Main: 237756416 01:35:34 INFO - PROCESS | 19066 | 01:38:37 INFO - PROCESS | 19066 | Cycle 1(1): loaded http://localhost:35593/tests/dromaeo/cssquery-yui.html (next: http://localhost:35593/tests/dromaeo/cssquery-dojo.html) 01:38:37 INFO - PROCESS | 19066 | RSS: Main: 353234944 01:38:37 INFO - PROCESS | 19066 | 01:38:37 INFO - PROCESS | 19066 | __start_tp_report 01:38:37 INFO - PROCESS | 19066 | _x_x_mozilla_page_load 01:38:37 INFO - PROCESS | 19066 | _x_x_mozilla_page_load_details 01:38:37 INFO - PROCESS | 19066 | |i|pagename|runs| 01:38:37 INFO - PROCESS | 19066 | |0;dojo.html;2650.1122124088424;2661.5342315094854;2698.231004163814;2699.8245114067586;2707.4043710383708;4706.105839890427;4764.190087685093;4772.880677983052;4864.6837955532865;4905.681130726504;4769.928451073228;4774.045190961804;4826.203676393391;4873.342098816659;4885.487023862496;4342.717723347981;4389.802458889341;4427.690061695683;4457.933131003021;4580.816767329303;4451.666125040635;4481.4846292676275;4489.483709373431;4514.8194072237075;4528.50186479487;4333.869983900457;4336.176126535948;4378.802953867052;4390.05613793036;4398.186335527937;4381.75900325482;4394.648428125743;4397.208502469554;4430.977845110786;4463.4420697412825;4422.071365013351;4431.578999994996;4431.822727090913;4436.667249956234;4464.397306363632;4674.766261686902;4711.95288047122;4747.121782470254;4764.714117152947;4768.976155119237;5166.405863325728;5166.9224961625605;5184.300119483897;5187.351581052369;5229.712365819878;5214.765335559909;5237.292965449654;5244.239585260154;5245.4754524547625;5250.789968401259;4716.363290955712;4784.354112194809;4825.734584597811;4834.444038935497;4846.709197448165;5252.763625636855;5341.198820177005;5341.839744807662;5343.038253114477;5347.171188465794;4903.754812259373;5097.413797413345;5145.45972672864;5146.974265128651;5153.123968925292;5121.129408000649;5144.176931690911;5183.688978661293;5245.868853278698;5261.210818377198;5133.845984620468;5151.5878729701535;5155.716435596079;5156.92264616031;5164.509371609691;5142.61430392722;5144.845654630367;5145.9742701287005;5146.202338637517;5178.792848286026;4301.225779359683;4332.588404101605;4333.544977777351;4393.077453734688;4398.428204333481;3840.8655697051026;3871.399933010388;3880.902977425587;3884.1649045454797;3886.2227554489214;4396.670249731283;4397.890052748707;4434.445694288214;4446.155230506193;4487.932681009787;5212.400573934046;5217.50433708797;5221.530062294411;5223.425423203445;5270.973645131749;4404.295312750009;4439.778011099496;4443.466783985878;4451.59935605797;4495.797689103998;4430.867073987785;4597.057603191338;4623.676342656049;4648.2330415481065;4670.346151538787;4847.933454639973;4854.95145048545;4855.320255164209;4855.635827312895;4905.950940490549;4971.577415919543;5171.767270472763;5182.429932707324;5183.870403239949;5239.47605239473;4776.785044672929;4825.662203645711;4827;4833.854984350475;4866.148424025852;5098.209777484496;5129.9743501282255;5130.204818253177;5131.615128865425;5182.53357197854;5074.771635276347;5108.182690769459;5138.306328645585;5172.870678233075;5175.896482070413;4986.426560945392;4998.475160108136;5026.271190677405;5036.521530454601;5076.314697515936;5019.974900125622;5039.319691841554;5043;5052.545270925487;5094.898102038012;4817.13291607514;4866.8053277868485;4896.730679812645;4950.6782059166035;4965.024141081786;5018.548330650259;5034.320366750589;5043.167877300351;5046.21783623539;5074.035933172685;4931.112399767932;4940.357753492023;4940.92588611164;4943;4985.401751789808 01:38:37 INFO - PROCESS | 19066 | |1;ext.html;542.9352620369334;585.5169485174731;587.7472686744701;589.8260013296077;602.8553147244661;27098.86450567747;40463.190736185294;41285.380719289235;41430.37854432186;41506.16987660245;41692.37461438081;42489.7875510622;42506;42524.57475425245;42536.787316063455;7600.315971562558;7740.612969351538;7740.729074482394;7778.611069446519;7928.841423171533;7674.040744906887;9992.650257240997;10179.94910025449;10230.590776368974;10593.099586535154;10330.121939635103;10391.584336626525;10393.16854651626;10401;10407.739806504822;7620.847583048363;10017.649382271586;10202.9489852551;10214.029667181605;10307.536160872742;9841.311108222428;10154.39073655583;10158.542865571068;10163.33938294016;10163.94918025405;39505.20989580221;39905.80047099775;39961.20077598461;39997.80001100005;40049.79975100135;3125.718685318332;3195.121341631047;3309.8014119152685;3443.9311213775586;3490.8080055596934;29123.708762912524;29558.704412956024;29905.850470747726;29910;31138.532922006187;3374.088995971074;3480.798342761527;3532.982335088308;3544.379733546619;3597.478365636994;264946;265046;267116;267710;269291;31276.84361578223;55370;56027.71986140043;56166.719166403906;56191.15713264304;32373.51439728406;34281;34309;34345.14137146541;34354;12933.094683372261;13118.0817342787;13132.803007954888;13142.4085916134;13144.474221031243;10340.793184136275;11670.299782013106;11733.530658773725;11827.349495777642;11945.163838531393;7969.960150199212;7986.560739159402;8026.317762990095;8048.798780030429;8073.596320183968;3106.8757249709756;3120.9063728088195;3133.3419981804077;3154.4006638738565;3193.5688682028094;803.1085495100434;810.7040930060485;817.2807929022422;925.3060204846231;978.5205249427871;27153.86423067872;28133.71866281311;28362.85818570894;28424.573631395546;28618.71381286202;959.7427370145132;995.0944640377367;1019.3628981886321;1021.6832781837654;1061.2677252695769;14211.78682319766;14630.981022451515;14815.481458148914;14857.628559286104;14982.850171498363;385066;385314;386761;386840;388370;50427.24359134616;51146.48853511491;51192.23211651828;51299.743501283;51317.23024154641;1090.3621381491757;1135.4266095621824;1202.2606097249954;1237.189640785287;1251.2805137046234;26448;29291.56062659019;29572;29611.851940740158;29902.401951961274;48062.759686201345;49721.25418118804;49838;54820;54823.72588137034;340133;344582;345174;347295;347487;33337.83331083329;37362.13189340576;38623.78578891814;39702.60297397104;42229.78885105555;41988.3701744468;42593.14813703646;42678.57321426746;42778.57221427746;43898;35921.46117808183;36505.63494365022;37386.81306593558;37714.245715086094;37837.43243851399;36939.44590831086;37039.81480092582;37532;37549.62450375571;37877.81061094677;35795.284094318486;36505.63494365022;36527.817360913024;37179.6282037187;37329.81335093307;32352.72131049491;33714.494282586274;33774;33813.66186338105;34041.48937765985;24892;25335.239942801745;25417.237482874803;25531.744682552937;25845 01:38:37 INFO - PROCESS | 19066 | |2;jquery.html;366.56378909098186;372.78005976473884;372.93473642112633;386.57090629401375;386.9961300386995;16349.673006539877;16845.410410635646;17076.060816655096;17301;17358.305667773304;15824.208789560533;16651.167441627902;17090.401835935743;17110.401135960245;17130.914345428286;5041.747912604374;5207.375114986207;5250.159974404096;5250.947490525104;5253.579713622901;3737.1965027519077;3930.8231129599235;5163.870903227431;5797.65214087154;6154.753809847601;6217.689115544227;6221.191245138126;6229.096780966757;6239.251289845225;6246.906296405557;6006.849828754294;6049.727762250709;6119.847003824895;6169.845753856144;6182.103594978703;3387.61042480113;4930.580900623451;5271.077561426773;5278.313819203479;5435.83692489226;19650.80349196504;20388.79611203899;20406.285779997776;20700.171993120257;20719.482012949647;1959.2358979997812;2109.7362829646295;2112.176251262009;2537.4544472938405;2585.4958283134797;13385.196888186643;13411.664708382272;13457.327133643279;13583.52457663977;13629.386677599532;1732.2724455728624;1793.8833975791663;1807.1777341309673;1874.4376686993983;1876.418310323804;64235.35764642387;66790.3320966789;67456;67517;68266.3173368265;8899.822003559893;8929.374943753875;9106.767097680227;9635.084666956767;9920.652777152909;12963.935180324039;13041.608751737464;13071.673208169872;13080.345982700826;13092;7328.377087947478;7375.88936165958;7468.365188958999;7563.773086807405;7588.506747061423;7230.240824713329;7270.200277969419;7315.963420182865;7393.593352365564;7410.184879663233;5878.61896591058;5956.8808623828145;5958.046712526062;6033.698315084228;6143.32423433422;1643.334449547935;1677.2200926569203;1731.904745239024;1786.4640607817603;1816.2008716164846;806.6087947345533;834.9373796965252;867.6876324523166;887.6493784955036;891.4562117108559;16918.238679259463;17066.146692665316;17420.303187872596;17537.91231043862;17613.119344032748;856.6102423397339;879.2570278114982;940.5015341868684;945.8297506448905;951.296040929707;9409;9863.210943124677;10060.748481288027;10123.088921996909;10159.593616255266;353865;360932;363951;363968;365498;62823;62955.68522157452;64146.35853641404;65262.673686631264;65373;873.7204094689765;876.1414690719167;904.3759805734154;905.8188362327561;906.8095699902963;15250.77123843121;15327.846721533087;15537.84462155364;15546;15868;34069.829650851585;34444.82777586096;34482.82758586191;34531.30937381289;34755.30489390249;44910.32634510419;44991.32513012373;45151.54848451474;45301.320480193484;45817.08365832598;7661.1572726998875;7780.766577002699;7824.687012519663;7892.723754668788;7951.08562515295;11715.355655439032;11915.404229788302;12067.879321207027;12095.274283543016;12165.513379464723;10006.399616023062;10346.430946298025;10373;10452.32059916103;10596;4599.724016559017;5482.862928426821;10369.222308326755;10522.31604945676;10703.946480267548;10297.74255643615;10581.62964296246;10644.254902156774;10755.354678719303;10793.514291856729;7632.122305934889;7794.610269486617;7815.179406162271;7843.882341764764;7976.122626511195;10563.735906602396;10596.47017649099;10661.200409969439;10673;10717.035466808025 01:38:37 INFO - PROCESS | 19066 | |3;mootools.html;1285.9421326040326;1381.0401770769315;1426.3795249066654;1484.4062375049978;1701.2089378439023;6699.832504187391;7544;7829.138794732575;7834.843303133941;8005.959970200155;7786.104597971235;7953.244441778036;7972.083210430802;7977.800554986128;7986.680532778696;1853.4439668099583;1906.256559941624;1907.3324336482258;2220.5780901628677;2251.4371407148215;1923.3941308487852;2127.6489379252403;2225.543763528473;2232.486528098538;2239.992003598379;2197.7362716474045;2215.678726584644;2216.5345277491665;2231.0852550454315;2239.1491233331394;1834.5597056706429;2198.9560208795815;2210.193279452988;2220.411590928405;2228.22012295696;2165.8808765517892;2231.8102961248314;2232.631615783394;2243.349428665685;2248.7976082152522;7773.961130194313;7821.335186509154;7827.804304892366;7832;7854;4532.79602417892;4691.859244222679;4695.436547614274;4700.4359476862655;4700.5064468230685;2841.3322869125946;2842.7157284271616;2893.8408387538675;3040.802347847383;3103.3482968576627;989.7723523589543;991.8016396720685;1020.3469779341227;1064.6539874540729;1067.2902519824308;10578.312409693346;10785.514651840685;10847.783044339149;10849.077828384598;10849.403282819441;4100.466939297872;4172.102997855475;4246.49042114942;4248.936265956013;4250.957490425056;9306.069393060776;9368.953155234316;9374.343795934219;9377.953110234404;9380.5309734513;4662.463816661128;4669.066186762593;4676.111538807616;4680.157571637138;4680.180968330596;3727.664510194041;3787.280416720814;4105.651019663303;4122.6083522065355;4142.440770495945;3661.56061272649;3763.510743603314;3802.923941521154;3808.0479880029993;3809.485719427897;1164.394514852289;1173.6831055614937;1189.1972918280126;1207.2937331661076;1211.9697007574882;777.7122464687989;855.4653341661461;887.2236792806294;899.3704406915185;906.3972458315146;5515.4760297771645;5525.917111243334;5532.944670553324;5543.667379957215;5755.597108202385;834.3742193354984;883.6112110671284;905.6467977488785;915.2220612479339;935.9578818953163;3760.605136460687;3772.264408440383;3819.5416550014174;3881.8835434936996;3891.630295121959;9419.858702119336;9488.240940724725;9728.708138755848;9732.951335243279;9836.065573770624;9532.761680957892;9627.56675949584;9634;9646.517674116267;9694.709158725249;7178.102737157856;7185.389241914496;7238.493305468672;7335.669894854637;7342.412606991428;5434.212039254365;5562.833115006556;5600.943990560042;5620.662760234399;5864.794732184353;8709.259712924473;8836.381453298207;9073.727788166101;9076.636934522545;9118.452892826452;8679.696210632597;9061.22979546746;9083.227925626132;9113.36206465541;9209.079092090737;5967.8209653710455;6157.84605384869;6172.290186628596;6874.140732408449;7041.753538626123;6953.096097507291;7283.2352602975925;7514.812129696801;7558.962205188939;7702.961485192538;6772.627505487246;6885.311468853275;6924.3421874921805;7023.086998690138;7024.438044956289;6752;6833.692483838338;6834.111565496453;6880.621565813928;6962.23415424313;6201.472874805692;6418.390252925965;6506.869862602816;6514.902276465762;6520.9347906520325;4884.145274576864;4922.4339200992345;4927.113119638356;4960.3630801836025;4977.9502204978935;4847.878803029811;4895.167821470287;4927.975360123177;4931.654784165074;4967.478414766398 01:38:37 INFO - PROCESS | 19066 | |4;prototype.html;301.6274900497885;305.43189667218974;312.0404755377215;315.4810336995641;317.8140787639231;4631.564215093324;4875.219964805632;4882.340883980662;4937.703737775736;4981.576565991895;4633.90732185357;4796.736179510125;4806.783694733736;4819.662623616348;4892.730899800509;3896.6687831534214;3897.47384103146;3904.7852368119884;3906.8437262509606;3914.8042597869994;3679.5952445231005;3687.2072504411544;3852.5184351956004;3873.360895452261;3909.569947305794;3807.5240594925635;3832.8083595820235;3833.4249862520564;3851.8844434667003;3857.1514266861245;3804.695624350059;3829.272438236726;3873.438351439054;3874.3219936511;3907.1404291056206;3471.8784842530645;3496.4755286707195;3499.8075105869166;3501.0897166736577;3513.664807373207;4568.5431456854385;4761.666683332168;4777.256301449946;4781.330613714083;4783.210770222909;4339.7396156230725;4345.109252603241;4385.3641222022625;4436.64506839452;4455.398521199629;4911.263310503417;5005.649604527648;5052;5083.186690129599;5087.618428617869;3654.835532401048;3664.706823454117;3665.3402387570227;3666.926661466782;3677.724170687209;5371.973140134274;5381.408045115034;5384.9730751346;5408.729563521808;5415.83752487422;3706.5737440194184;3708.49935258742;3712.090537818198;3718;3718.1262403335195;3619.692326152254;3773.509443772292;3792.58281589025;3805.1818858945458;3811.942820857689;4301.419308393327;4306.729514793144;4316.935245971313;4330.372096046056;4334.869953901388;5076.670016448919;5080.161773307437;5080.644354895196;5097.439281679012;5109.284700141983;1234.1854376111723;1248.2759999200441;1275.2284867655121;1283.4224598930518;1327.9468821247235;820.2248874813245;844.932405407566;847.3856454070749;851.012884913721;855.9358048146414;3991.4212439196153;4003.979980100139;4021.828212765133;4043.8786836394956;4075.449814275094;4625.352450656911;4638.698484598491;4652.581267685924;4656;4745.549172828576;3917.216556688674;3940.4680368150507;3955.20895820837;3974.3044967130636;3987.4616926715103;2325.976740232576;2488.5645012122804;2508.548461276951;2526.608375701769;2527.4186937004592;4420.226460369422;4448.510663826976;4454.28731402974;4459.375687403766;4461.7730124216105;4785.473597904228;4796.736179510161;4800.759962001886;4821;4823.710577365369;4451.221036318631;4458.71018383804;4587.839425620154;5015;5026.2460630904925;5233.241180028951;5243.5018673227505;5272.604554658339;5325.7337133143965;5344.5991550634635;5205.557527610044;5210.218467229945;5261.158214685632;5269.419174247787;5283.679080229943;4738.928916066331;4998.875028124326;5009.674371165863;5009.899802004013;5015.1975683890405;3705.9444108338935;3724.832382542738;3736.4021756519915;3739.3546839390583;3751.6811071059265;5014.4484106747495;5208.8437346879655;5253.527182553588;5289.920651190158;5360.0887849064975;4905.754712264301;5060.645754797276;5084.618653600921;5100.2349647553165;5109.20807274873;5096.159133742891;5098.923516147335;5100.69395836251;5109.131447653834;5122.154844450624;4934.901301974012;5022.271770593316;5025.974870125772;5027.472115427828;5039.773210205476;5105.540501354896;5122.206058060858;5147.150720131136;5156.510131537498;5168.483151684802;5067.467915868928;5069;5075.670081444694;5076;5076.847694569169 01:38:37 INFO - PROCESS | 19066 | |5;yui.html;674.4840197249102;677.9864402711946;713.7046261036219;716.2228981555013;741.6921977379387;12760.680982975431;13336.866631333683;13496.257705826176;13509.864901350984;13524.459021639148;14321.140731556114;14884.925575372135;14900.776488352656;14902.776458353133;15468.922655386736;634.5336177909234;766.2452484302958;768.3046842607449;807.628490894188;814.8207394373258;786.4455558831011;809.6963638635511;813.7680760983121;814.4217605500102;821.5194111444812;829.1128492513013;835.5613303015905;837.2464781696461;839.093778718985;839.8824164616958;655.9573627714183;805.8227190018187;834.5451728807784;834.8789425533324;835.0730688935276;605.7546693589103;608.5162295974711;608.5739982012609;610;610.6031079798122;14181.78727319091;14233.928830355886;14260.144391336553;14261.28693565328;14394.496192633313;12928.28894410807;13430.19418834873;13625.659358516017;13658.317533180241;13854.65363365924;12532.498700051987;12598.874011259863;12750.426230819543;12796.232226066373;13031.543895963596;4134.896627584334;4164.708470407073;4174.728642638219;4181.226473102486;4257.467816522934;65681.343186568;65788.3421165787;65896.3410365895;65988.67005664941;66254.66872665654;10523.421211833424;10570.735731606772;10573.312734672221;10812.56749730002;11200.887991120147;20399.79600203979;20675.069621867053;20691.379258622266;20723.689144662843;20757;6784.423324017415;6828;6876.243613202544;6929.237783843773;6953.89569156463;3794.1842503861803;3841.5966323536186;3860.0542866997766;3874.4575759393706;3929.941050884239;2939.8236105833716;3036.028470889294;3040.1791516290477;3062.1885200421907;3068.831214283191;525.461402062881;532.6777299733606;542.0432935868196;543.4782608695697;545.1849485019842;538.5530010091614;546.546366515791;558.8574913397058;573.7475510775246;587.6943989125631;7579.772606821804;7596.8480630387085;7664.73173438927;7932.960335198287;8078.071021832565;547.4252035362853;561.3208018297905;562.6961440821992;567.6764244380663;581;3877.2051729395407;3880.72933008612;3986.0832008638176;4024.879253622396;4072.3687828386646;107206;108039;109004;112070.43964780286;112402.43798780954;78236;81772.59113704393;81844;82357;82581;61026.084608730904;63211.68394158;77601.61199194081;81771.02279805655;83824.58087709645;8429.325653947546;8553.914460855312;8590.484570925764;8910.55447227623;8964.462132272085;41276.58723412728;41775.7911210442;42194;42450;43508;19945.601087978448;19964.3012494562;22518;45123.64629061134;58236.70881645734;11367.147463940073;11369.772604548029;11546.249493782878;11937.701557461132;11940.641780746591;12727.745445091232;12752.87247127554;12764.042696797964;13459.865401346253;13911.115970696716;12434.129610927148;12729.172603780724;12987.610371688865;13020.47918083266;13474.607379187857;11125.221234513507;11568.88431115678;11612.303261803982;12266;12286;11378.943105284421;11823.704407389883;12056.457459414172;12136.514539418324;12432.937835310766;9921.702348929544;10627.574897004033;10806.891931080903;10855.294405863593;10943.562257509611;9944.35361701516;10031.498425078571;10234.437105959243;10766.246362754531;10869.67390978272 01:38:37 INFO - PROCESS | 19066 | __end_tp_report 01:38:37 INFO - PROCESS | 19066 | __start_cc_report 01:38:37 INFO - PROCESS | 19066 | _x_x_mozilla_cycle_collect,919 01:38:37 INFO - PROCESS | 19066 | __end_cc_report 01:38:37 INFO - PROCESS | 19066 | __startTimestamp1466584717671__endTimestamp 01:38:37 INFO - PROCESS | 19066 | 01:38:37 INFO - PROCESS | 19066 | ------- Summary: start ------- 01:38:37 INFO - PROCESS | 19066 | Number of tests: 6 01:38:37 INFO - PROCESS | 19066 | 01:38:37 INFO - PROCESS | 19066 | [#0] dojo.html Cycles:165 Average:4767.72 Median:4866.81 stddev:506.37 (10.4%) stddev-sans-first:479.90 01:38:37 INFO - PROCESS | 19066 | Values: 2650.1 2661.5 2698.2 2699.8 2707.4 4706.1 4764.2 4772.9 4864.7 4905.7 4769.9 4774.0 4826.2 4873.3 4885.5 4342.7 4389.8 4427.7 4457.9 4580.8 4451.7 4481.5 4489.5 4514.8 4528.5 4333.9 4336.2 4378.8 4390.1 4398.2 4381.8 4394.6 4397.2 4431.0 4463.4 4422.1 4431.6 4431.8 4436.7 4464.4 4674.8 4712.0 4747.1 4764.7 4769.0 5166.4 5166.9 5184.3 5187.4 5229.7 5214.8 5237.3 5244.2 5245.5 5250.8 4716.4 4784.4 4825.7 4834.4 4846.7 5252.8 5341.2 5341.8 5343.0 5347.2 4903.8 5097.4 5145.5 5147.0 5153.1 5121.1 5144.2 5183.7 5245.9 5261.2 5133.8 5151.6 5155.7 5156.9 5164.5 5142.6 5144.8 5146.0 5146.2 5178.8 4301.2 4332.6 4333.5 4393.1 4398.4 3840.9 3871.4 3880.9 3884.2 3886.2 4396.7 4397.9 4434.4 4446.2 4487.9 5212.4 5217.5 5221.5 5223.4 5271.0 4404.3 4439.8 4443.5 4451.6 4495.8 4430.9 4597.1 4623.7 4648.2 4670.3 4847.9 4855.0 4855.3 4855.6 4906.0 4971.6 5171.8 5182.4 5183.9 5239.5 4776.8 4825.7 4827.0 4833.9 4866.1 5098.2 5130.0 5130.2 5131.6 5182.5 5074.8 5108.2 5138.3 5172.9 5175.9 4986.4 4998.5 5026.3 5036.5 5076.3 5020.0 5039.3 5043.0 5052.5 5094.9 4817.1 4866.8 4896.7 4950.7 4965.0 5018.5 5034.3 5043.2 5046.2 5074.0 4931.1 4940.4 4940.9 4943.0 4985.4 01:38:37 INFO - PROCESS | 19066 | 01:38:37 INFO - PROCESS | 19066 | [#1] ext.html Cycles:180 Average:48694.33 Median:347391.00 stddev:88593.56 (25.5%) stddev-sans-first:88768.32 01:38:37 INFO - PROCESS | 19066 | Values: 542.9 585.5 587.7 589.8 602.9 27098.9 40463.2 41285.4 41430.4 41506.2 41692.4 42489.8 42506.0 42524.6 42536.8 7600.3 7740.6 7740.7 7778.6 7928.8 7674.0 9992.7 10179.9 10230.6 10593.1 10330.1 10391.6 10393.2 10401.0 10407.7 7620.8 10017.6 10202.9 10214.0 10307.5 9841.3 10154.4 10158.5 10163.3 10163.9 39505.2 39905.8 39961.2 39997.8 40049.8 3125.7 3195.1 3309.8 3443.9 3490.8 29123.7 29558.7 29905.9 29910.0 31138.5 3374.1 3480.8 3533.0 3544.4 3597.5 264946.0 265046.0 267116.0 267710.0 269291.0 31276.8 55370.0 56027.7 56166.7 56191.2 32373.5 34281.0 34309.0 34345.1 34354.0 12933.1 13118.1 13132.8 13142.4 13144.5 10340.8 11670.3 11733.5 11827.3 11945.2 7970.0 7986.6 8026.3 8048.8 8073.6 3106.9 3120.9 3133.3 3154.4 3193.6 803.1 810.7 817.3 925.3 978.5 27153.9 28133.7 28362.9 28424.6 28618.7 959.7 995.1 1019.4 1021.7 1061.3 14211.8 14631.0 14815.5 14857.6 14982.9 385066.0 385314.0 386761.0 386840.0 388370.0 50427.2 51146.5 51192.2 51299.7 51317.2 1090.4 1135.4 1202.3 1237.2 1251.3 26448.0 29291.6 29572.0 29611.9 29902.4 48062.8 49721.3 49838.0 54820.0 54823.7 340133.0 344582.0 345174.0 347295.0 347487.0 33337.8 37362.1 38623.8 39702.6 42229.8 41988.4 42593.1 42678.6 42778.6 43898.0 35921.5 36505.6 37386.8 37714.2 37837.4 36939.4 37039.8 37532.0 37549.6 37877.8 35795.3 36505.6 36527.8 37179.6 37329.8 32352.7 33714.5 33774.0 33813.7 34041.5 24892.0 25335.2 25417.2 25531.7 25845.0 01:38:37 INFO - PROCESS | 19066 | 01:38:37 INFO - PROCESS | 19066 | [#2] jquery.html Cycles:180 Average:23043.47 Median:2061.88 stddev:59456.17 (2883.6%) stddev-sans-first:59598.58 01:38:37 INFO - PROCESS | 19066 | Values: 366.6 372.8 372.9 386.6 387.0 16349.7 16845.4 17076.1 17301.0 17358.3 15824.2 16651.2 17090.4 17110.4 17130.9 5041.7 5207.4 5250.2 5250.9 5253.6 3737.2 3930.8 5163.9 5797.7 6154.8 6217.7 6221.2 6229.1 6239.3 6246.9 6006.8 6049.7 6119.8 6169.8 6182.1 3387.6 4930.6 5271.1 5278.3 5435.8 19650.8 20388.8 20406.3 20700.2 20719.5 1959.2 2109.7 2112.2 2537.5 2585.5 13385.2 13411.7 13457.3 13583.5 13629.4 1732.3 1793.9 1807.2 1874.4 1876.4 64235.4 66790.3 67456.0 67517.0 68266.3 8899.8 8929.4 9106.8 9635.1 9920.7 12963.9 13041.6 13071.7 13080.3 13092.0 7328.4 7375.9 7468.4 7563.8 7588.5 7230.2 7270.2 7316.0 7393.6 7410.2 5878.6 5956.9 5958.0 6033.7 6143.3 1643.3 1677.2 1731.9 1786.5 1816.2 806.6 834.9 867.7 887.6 891.5 16918.2 17066.1 17420.3 17537.9 17613.1 856.6 879.3 940.5 945.8 951.3 9409.0 9863.2 10060.7 10123.1 10159.6 353865.0 360932.0 363951.0 363968.0 365498.0 62823.0 62955.7 64146.4 65262.7 65373.0 873.7 876.1 904.4 905.8 906.8 15250.8 15327.8 15537.8 15546.0 15868.0 34069.8 34444.8 34482.8 34531.3 34755.3 44910.3 44991.3 45151.5 45301.3 45817.1 7661.2 7780.8 7824.7 7892.7 7951.1 11715.4 11915.4 12067.9 12095.3 12165.5 10006.4 10346.4 10373.0 10452.3 10596.0 4599.7 5482.9 10369.2 10522.3 10703.9 10297.7 10581.6 10644.3 10755.4 10793.5 7632.1 7794.6 7815.2 7843.9 7976.1 10563.7 10596.5 10661.2 10673.0 10717.0 01:38:37 INFO - PROCESS | 19066 | 01:38:37 INFO - PROCESS | 19066 | [#3] mootools.html Cycles:180 Average:5204.06 Median:5529.43 stddev:2890.75 (52.3%) stddev-sans-first:2883.86 01:38:37 INFO - PROCESS | 19066 | Values: 1285.9 1381.0 1426.4 1484.4 1701.2 6699.8 7544.0 7829.1 7834.8 8006.0 7786.1 7953.2 7972.1 7977.8 7986.7 1853.4 1906.3 1907.3 2220.6 2251.4 1923.4 2127.6 2225.5 2232.5 2240.0 2197.7 2215.7 2216.5 2231.1 2239.1 1834.6 2199.0 2210.2 2220.4 2228.2 2165.9 2231.8 2232.6 2243.3 2248.8 7774.0 7821.3 7827.8 7832.0 7854.0 4532.8 4691.9 4695.4 4700.4 4700.5 2841.3 2842.7 2893.8 3040.8 3103.3 989.8 991.8 1020.3 1064.7 1067.3 10578.3 10785.5 10847.8 10849.1 10849.4 4100.5 4172.1 4246.5 4248.9 4251.0 9306.1 9369.0 9374.3 9378.0 9380.5 4662.5 4669.1 4676.1 4680.2 4680.2 3727.7 3787.3 4105.7 4122.6 4142.4 3661.6 3763.5 3802.9 3808.0 3809.5 1164.4 1173.7 1189.2 1207.3 1212.0 777.7 855.5 887.2 899.4 906.4 5515.5 5525.9 5532.9 5543.7 5755.6 834.4 883.6 905.6 915.2 936.0 3760.6 3772.3 3819.5 3881.9 3891.6 9419.9 9488.2 9728.7 9733.0 9836.1 9532.8 9627.6 9634.0 9646.5 9694.7 7178.1 7185.4 7238.5 7335.7 7342.4 5434.2 5562.8 5600.9 5620.7 5864.8 8709.3 8836.4 9073.7 9076.6 9118.5 8679.7 9061.2 9083.2 9113.4 9209.1 5967.8 6157.8 6172.3 6874.1 7041.8 6953.1 7283.2 7514.8 7559.0 7703.0 6772.6 6885.3 6924.3 7023.1 7024.4 6752.0 6833.7 6834.1 6880.6 6962.2 6201.5 6418.4 6506.9 6514.9 6520.9 4884.1 4922.4 4927.1 4960.4 4978.0 4847.9 4895.2 4928.0 4931.7 4967.5 01:38:37 INFO - PROCESS | 19066 | 01:38:37 INFO - PROCESS | 19066 | [#4] prototype.html Cycles:180 Average:4165.95 Median:4632.74 stddev:1213.62 (26.2%) stddev-sans-first:1181.86 01:38:37 INFO - PROCESS | 19066 | Values: 301.6 305.4 312.0 315.5 317.8 4631.6 4875.2 4882.3 4937.7 4981.6 4633.9 4796.7 4806.8 4819.7 4892.7 3896.7 3897.5 3904.8 3906.8 3914.8 3679.6 3687.2 3852.5 3873.4 3909.6 3807.5 3832.8 3833.4 3851.9 3857.2 3804.7 3829.3 3873.4 3874.3 3907.1 3471.9 3496.5 3499.8 3501.1 3513.7 4568.5 4761.7 4777.3 4781.3 4783.2 4339.7 4345.1 4385.4 4436.6 4455.4 4911.3 5005.6 5052.0 5083.2 5087.6 3654.8 3664.7 3665.3 3666.9 3677.7 5372.0 5381.4 5385.0 5408.7 5415.8 3706.6 3708.5 3712.1 3718.0 3718.1 3619.7 3773.5 3792.6 3805.2 3811.9 4301.4 4306.7 4316.9 4330.4 4334.9 5076.7 5080.2 5080.6 5097.4 5109.3 1234.2 1248.3 1275.2 1283.4 1327.9 820.2 844.9 847.4 851.0 855.9 3991.4 4004.0 4021.8 4043.9 4075.4 4625.4 4638.7 4652.6 4656.0 4745.5 3917.2 3940.5 3955.2 3974.3 3987.5 2326.0 2488.6 2508.5 2526.6 2527.4 4420.2 4448.5 4454.3 4459.4 4461.8 4785.5 4796.7 4800.8 4821.0 4823.7 4451.2 4458.7 4587.8 5015.0 5026.2 5233.2 5243.5 5272.6 5325.7 5344.6 5205.6 5210.2 5261.2 5269.4 5283.7 4738.9 4998.9 5009.7 5009.9 5015.2 3705.9 3724.8 3736.4 3739.4 3751.7 5014.4 5208.8 5253.5 5289.9 5360.1 4905.8 5060.6 5084.6 5100.2 5109.2 5096.2 5098.9 5100.7 5109.1 5122.2 4934.9 5022.3 5026.0 5027.5 5039.8 5105.5 5122.2 5147.2 5156.5 5168.5 5067.5 5069.0 5075.7 5076.0 5076.8 01:38:37 INFO - PROCESS | 19066 | 01:38:37 INFO - PROCESS | 19066 | [#5] yui.html Cycles:180 Average:17583.19 Median:22674.48 stddev:25467.86 (112.3%) stddev-sans-first:25507.65 01:38:37 INFO - PROCESS | 19066 | Values: 674.5 678.0 713.7 716.2 741.7 12760.7 13336.9 13496.3 13509.9 13524.5 14321.1 14884.9 14900.8 14902.8 15468.9 634.5 766.2 768.3 807.6 814.8 786.4 809.7 813.8 814.4 821.5 829.1 835.6 837.2 839.1 839.9 656.0 805.8 834.5 834.9 835.1 605.8 608.5 608.6 610.0 610.6 14181.8 14233.9 14260.1 14261.3 14394.5 12928.3 13430.2 13625.7 13658.3 13854.7 12532.5 12598.9 12750.4 12796.2 13031.5 4134.9 4164.7 4174.7 4181.2 4257.5 65681.3 65788.3 65896.3 65988.7 66254.7 10523.4 10570.7 10573.3 10812.6 11200.9 20399.8 20675.1 20691.4 20723.7 20757.0 6784.4 6828.0 6876.2 6929.2 6953.9 3794.2 3841.6 3860.1 3874.5 3929.9 2939.8 3036.0 3040.2 3062.2 3068.8 525.5 532.7 542.0 543.5 545.2 538.6 546.5 558.9 573.7 587.7 7579.8 7596.8 7664.7 7933.0 8078.1 547.4 561.3 562.7 567.7 581.0 3877.2 3880.7 3986.1 4024.9 4072.4 107206.0 108039.0 109004.0 112070.4 112402.4 78236.0 81772.6 81844.0 82357.0 82581.0 61026.1 63211.7 77601.6 81771.0 83824.6 8429.3 8553.9 8590.5 8910.6 8964.5 41276.6 41775.8 42194.0 42450.0 43508.0 19945.6 19964.3 22518.0 45123.6 58236.7 11367.1 11369.8 11546.2 11937.7 11940.6 12727.7 12752.9 12764.0 13459.9 13911.1 12434.1 12729.2 12987.6 13020.5 13474.6 11125.2 11568.9 11612.3 12266.0 12286.0 11378.9 11823.7 12056.5 12136.5 12432.9 9921.7 10627.6 10806.9 10855.3 10943.6 9944.4 10031.5 10234.4 10766.2 10869.7 01:38:37 INFO - PROCESS | 19066 | -------- Summary: end -------- 01:38:37 INFO - PROCESS | 19066 | 01:38:38 INFO - TEST-INFO | 19066: exit 0 01:38:38 INFO - TEST-OK | dromaeo_css | took 1120793ms 01:38:38 INFO - TEST-START | kraken 01:38:38 INFO - operating with platform_type : linux_ 01:38:38 INFO - Initialising browser for kraken test... 01:38:38 INFO - TEST-INFO | started process 19251 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqbj5cb/profile http://localhost:35593/getInfo.html) 01:38:42 INFO - PROCESS | 19251 | __metrics Screen width/height:1600/1200 01:38:42 INFO - PROCESS | 19251 | colorDepth:24 01:38:42 INFO - PROCESS | 19251 | Browser inner width/height: 1024/697 01:38:42 INFO - PROCESS | 19251 | __metrics 01:38:44 INFO - PROCESS | 19251 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:38:44 INFO - TEST-INFO | 19251: exit 0 01:38:44 INFO - Browser initialized. 01:38:44 INFO - Running cycle 1/1 for kraken test... 01:38:44 INFO - TEST-INFO | started process 19331 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqbj5cb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:38:57 INFO - PROCESS | 19331 | RSS: Main: 175546368 01:38:57 INFO - PROCESS | 19331 | 01:38:59 INFO - PROCESS | 19331 | Cycle 1(1): loaded http://localhost:35593/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35593/tests/kraken/driver.html?testName=audio-beat-detection) 01:39:00 INFO - PROCESS | 19331 | RSS: Main: 233431040 01:39:00 INFO - PROCESS | 19331 | 01:39:03 INFO - PROCESS | 19331 | Cycle 1(1): loaded http://localhost:35593/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35593/tests/kraken/driver.html?testName=audio-dft) 01:39:04 INFO - PROCESS | 19331 | RSS: Main: 221089792 01:39:04 INFO - PROCESS | 19331 | 01:39:07 INFO - PROCESS | 19331 | Cycle 1(1): loaded http://localhost:35593/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35593/tests/kraken/driver.html?testName=audio-fft) 01:39:08 INFO - PROCESS | 19331 | RSS: Main: 289615872 01:39:08 INFO - PROCESS | 19331 | 01:39:10 INFO - PROCESS | 19331 | Cycle 1(1): loaded http://localhost:35593/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35593/tests/kraken/driver.html?testName=audio-oscillator) 01:39:10 INFO - PROCESS | 19331 | RSS: Main: 199737344 01:39:10 INFO - PROCESS | 19331 | 01:39:13 INFO - PROCESS | 19331 | Cycle 1(1): loaded http://localhost:35593/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35593/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:39:13 INFO - PROCESS | 19331 | RSS: Main: 203329536 01:39:13 INFO - PROCESS | 19331 | 01:39:16 INFO - PROCESS | 19331 | Cycle 1(1): loaded http://localhost:35593/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35593/tests/kraken/driver.html?testName=imaging-darkroom) 01:39:17 INFO - PROCESS | 19331 | RSS: Main: 240050176 01:39:17 INFO - PROCESS | 19331 | 01:39:20 INFO - PROCESS | 19331 | Cycle 1(1): loaded http://localhost:35593/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35593/tests/kraken/driver.html?testName=imaging-desaturate) 01:39:21 INFO - PROCESS | 19331 | RSS: Main: 235446272 01:39:21 INFO - PROCESS | 19331 | 01:39:24 INFO - PROCESS | 19331 | Cycle 1(1): loaded http://localhost:35593/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35593/tests/kraken/driver.html?testName=json-parse-financial) 01:39:25 INFO - PROCESS | 19331 | RSS: Main: 238227456 01:39:25 INFO - PROCESS | 19331 | 01:39:26 INFO - PROCESS | 19331 | Cycle 1(1): loaded http://localhost:35593/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35593/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:39:27 INFO - PROCESS | 19331 | RSS: Main: 227020800 01:39:27 INFO - PROCESS | 19331 | 01:39:29 INFO - PROCESS | 19331 | Cycle 1(1): loaded http://localhost:35593/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35593/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:39:29 INFO - PROCESS | 19331 | RSS: Main: 232865792 01:39:29 INFO - PROCESS | 19331 | 01:39:32 INFO - PROCESS | 19331 | Cycle 1(1): loaded http://localhost:35593/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35593/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:39:32 INFO - PROCESS | 19331 | RSS: Main: 238075904 01:39:32 INFO - PROCESS | 19331 | 01:39:35 INFO - PROCESS | 19331 | Cycle 1(1): loaded http://localhost:35593/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35593/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:39:36 INFO - PROCESS | 19331 | RSS: Main: 240676864 01:39:36 INFO - PROCESS | 19331 | 01:39:39 INFO - PROCESS | 19331 | Cycle 1(1): loaded http://localhost:35593/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35593/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:39:39 INFO - PROCESS | 19331 | RSS: Main: 240885760 01:39:39 INFO - PROCESS | 19331 | 01:39:41 INFO - PROCESS | 19331 | Cycle 1(1): loaded http://localhost:35593/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35593/tests/kraken/driver.html?testName=ai-astar) 01:39:41 INFO - PROCESS | 19331 | RSS: Main: 284028928 01:39:41 INFO - PROCESS | 19331 | 01:39:41 INFO - PROCESS | 19331 | __start_tp_report 01:39:41 INFO - PROCESS | 19331 | _x_x_mozilla_page_load 01:39:41 INFO - PROCESS | 19331 | _x_x_mozilla_page_load_details 01:39:41 INFO - PROCESS | 19331 | |i|pagename|runs| 01:39:41 INFO - PROCESS | 19331 | |0;ai-astar;113;107;114;114;113;112;112;113;111;112 01:39:41 INFO - PROCESS | 19331 | |1;audio-beat-detection;162;129;141;185;131;161;155;131;191;131 01:39:41 INFO - PROCESS | 19331 | |2;audio-dft;163;161;161;162;162;161;162;161;160;161 01:39:41 INFO - PROCESS | 19331 | |3;audio-fft;75;76;76;110;76;76;80;75;97;74 01:39:41 INFO - PROCESS | 19331 | |4;audio-oscillator;88;87;117;86;85;86;123;85;86;133 01:39:41 INFO - PROCESS | 19331 | |5;imaging-gaussian-blur;117;117;117;116;117;117;116;117;117;117 01:39:41 INFO - PROCESS | 19331 | |6;imaging-darkroom;148;147;148;147;146;147;147;147;148;146 01:39:41 INFO - PROCESS | 19331 | |7;imaging-desaturate;95;95;95;95;95;95;95;96;95;95 01:39:41 INFO - PROCESS | 19331 | |8;json-parse-financial;64;64;65;65;66;64;65;65;64;65 01:39:41 INFO - PROCESS | 19331 | |9;json-stringify-tinderbox;65;65;65;65;65;65;66;64;65;65 01:39:41 INFO - PROCESS | 19331 | |10;stanford-crypto-aes;89;83;84;83;82;85;84;90;121;83 01:39:41 INFO - PROCESS | 19331 | |11;stanford-crypto-ccm;132;143;130;130;134;133;129;135;134;142 01:39:41 INFO - PROCESS | 19331 | |12;stanford-crypto-pbkdf2;175;172;172;171;171;174;167;174;169;166 01:39:41 INFO - PROCESS | 19331 | |13;stanford-crypto-sha256-iterative;67;67;71;70;67;75;66;67;66;66 01:39:41 INFO - PROCESS | 19331 | __end_tp_report 01:39:41 INFO - PROCESS | 19331 | __start_cc_report 01:39:41 INFO - PROCESS | 19331 | _x_x_mozilla_cycle_collect,1936 01:39:41 INFO - PROCESS | 19331 | __end_cc_report 01:39:41 INFO - PROCESS | 19331 | __startTimestamp1466584781789__endTimestamp 01:39:41 INFO - PROCESS | 19331 | 01:39:41 INFO - PROCESS | 19331 | ------- Summary: start ------- 01:39:41 INFO - PROCESS | 19331 | Number of tests: 14 01:39:41 INFO - PROCESS | 19331 | 01:39:41 INFO - PROCESS | 19331 | [#0] ai-astar Cycles:10 Average:112.10 Median:113.00 stddev:2.02 (1.8%) stddev-sans-first:2.12 01:39:41 INFO - PROCESS | 19331 | Values: 113.0 107.0 114.0 114.0 113.0 112.0 112.0 113.0 111.0 112.0 01:39:41 INFO - PROCESS | 19331 | 01:39:41 INFO - PROCESS | 19331 | [#1] audio-beat-detection Cycles:10 Average:151.70 Median:158.00 stddev:23.03 (14.6%) stddev-sans-first:24.12 01:39:41 INFO - PROCESS | 19331 | Values: 162.0 129.0 141.0 185.0 131.0 161.0 155.0 131.0 191.0 131.0 01:39:41 INFO - PROCESS | 19331 | 01:39:41 INFO - PROCESS | 19331 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:0.84 (0.5%) stddev-sans-first:0.67 01:39:41 INFO - PROCESS | 19331 | Values: 163.0 161.0 161.0 162.0 162.0 161.0 162.0 161.0 160.0 161.0 01:39:41 INFO - PROCESS | 19331 | 01:39:41 INFO - PROCESS | 19331 | [#3] audio-fft Cycles:10 Average:81.50 Median:76.00 stddev:12.09 (15.9%) stddev-sans-first:12.60 01:39:41 INFO - PROCESS | 19331 | Values: 75.0 76.0 76.0 110.0 76.0 76.0 80.0 75.0 97.0 74.0 01:39:41 INFO - PROCESS | 19331 | 01:39:41 INFO - PROCESS | 19331 | [#4] audio-oscillator Cycles:10 Average:97.60 Median:86.00 stddev:18.86 (21.9%) stddev-sans-first:19.68 01:39:41 INFO - PROCESS | 19331 | Values: 88.0 87.0 117.0 86.0 85.0 86.0 123.0 85.0 86.0 133.0 01:39:41 INFO - PROCESS | 19331 | 01:39:41 INFO - PROCESS | 19331 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 01:39:41 INFO - PROCESS | 19331 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 117.0 01:39:41 INFO - PROCESS | 19331 | 01:39:41 INFO - PROCESS | 19331 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 01:39:41 INFO - PROCESS | 19331 | Values: 148.0 147.0 148.0 147.0 146.0 147.0 147.0 147.0 148.0 146.0 01:39:41 INFO - PROCESS | 19331 | 01:39:41 INFO - PROCESS | 19331 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 01:39:41 INFO - PROCESS | 19331 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 01:39:41 INFO - PROCESS | 19331 | 01:39:41 INFO - PROCESS | 19331 | [#8] json-parse-financial Cycles:10 Average:64.70 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 01:39:41 INFO - PROCESS | 19331 | Values: 64.0 64.0 65.0 65.0 66.0 64.0 65.0 65.0 64.0 65.0 01:39:41 INFO - PROCESS | 19331 | 01:39:41 INFO - PROCESS | 19331 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:0.47 (0.7%) stddev-sans-first:0.50 01:39:41 INFO - PROCESS | 19331 | Values: 65.0 65.0 65.0 65.0 65.0 65.0 66.0 64.0 65.0 65.0 01:39:41 INFO - PROCESS | 19331 | 01:39:41 INFO - PROCESS | 19331 | [#10] stanford-crypto-aes Cycles:10 Average:88.40 Median:84.00 stddev:11.76 (14.0%) stddev-sans-first:12.47 01:39:41 INFO - PROCESS | 19331 | Values: 89.0 83.0 84.0 83.0 82.0 85.0 84.0 90.0 121.0 83.0 01:39:41 INFO - PROCESS | 19331 | 01:39:41 INFO - PROCESS | 19331 | [#11] stanford-crypto-ccm Cycles:10 Average:134.20 Median:134.00 stddev:4.80 (3.6%) stddev-sans-first:5.03 01:39:41 INFO - PROCESS | 19331 | Values: 132.0 143.0 130.0 130.0 134.0 133.0 129.0 135.0 134.0 142.0 01:39:41 INFO - PROCESS | 19331 | 01:39:41 INFO - PROCESS | 19331 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.10 Median:172.00 stddev:3.00 (1.7%) stddev-sans-first:2.83 01:39:41 INFO - PROCESS | 19331 | Values: 175.0 172.0 172.0 171.0 171.0 174.0 167.0 174.0 169.0 166.0 01:39:41 INFO - PROCESS | 19331 | 01:39:41 INFO - PROCESS | 19331 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:67.00 stddev:2.94 (4.4%) stddev-sans-first:3.08 01:39:41 INFO - PROCESS | 19331 | Values: 67.0 67.0 71.0 70.0 67.0 75.0 66.0 67.0 66.0 66.0 01:39:41 INFO - PROCESS | 19331 | -------- Summary: end -------- 01:39:41 INFO - PROCESS | 19331 | 01:39:42 INFO - TEST-INFO | 19331: exit 0 01:39:42 INFO - TEST-OK | kraken | took 64354ms 01:39:42 INFO - SUITE-END | took 1185s 01:39:42 INFO - Completed test suite (00:19:45) 01:39:42 INFO - javascript benchmark 01:39:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2650.1122124088424, 2661.5342315094854, 2698.231004163814, 2699.8245114067586, 2707.4043710383708, 4706.105839890427, 4764.190087685093, 4772.880677983052, 4864.6837955532865, 4905.681130726504, 4769.928451073228, 4774.045190961804, 4826.203676393391, 4873.342098816659, 4885.487023862496, 4342.717723347981, 4389.802458889341, 4427.690061695683, 4457.933131003021, 4580.816767329303, 4451.666125040635, 4481.4846292676275, 4489.483709373431, 4514.8194072237075, 4528.50186479487, 4333.869983900457, 4336.176126535948, 4378.802953867052, 4390.05613793036, 4398.186335527937, 4381.75900325482, 4394.648428125743, 4397.208502469554, 4430.977845110786, 4463.4420697412825, 4422.071365013351, 4431.578999994996, 4431.822727090913, 4436.667249956234, 4464.397306363632, 4674.766261686902, 4711.95288047122, 4747.121782470254, 4764.714117152947, 4768.976155119237, 5166.405863325728, 5166.9224961625605, 5184.300119483897, 5187.351581052369, 5229.712365819878, 5214.765335559909, 5237.292965449654, 5244.239585260154, 5245.4754524547625, 5250.789968401259, 4716.363290955712, 4784.354112194809, 4825.734584597811, 4834.444038935497, 4846.709197448165, 5252.763625636855, 5341.198820177005, 5341.839744807662, 5343.038253114477, 5347.171188465794, 4903.754812259373, 5097.413797413345, 5145.45972672864, 5146.974265128651, 5153.123968925292, 5121.129408000649, 5144.176931690911, 5183.688978661293, 5245.868853278698, 5261.210818377198, 5133.845984620468, 5151.5878729701535, 5155.716435596079, 5156.92264616031, 5164.509371609691, 5142.61430392722, 5144.845654630367, 5145.9742701287005, 5146.202338637517, 5178.792848286026, 4301.225779359683, 4332.588404101605, 4333.544977777351, 4393.077453734688, 4398.428204333481, 3840.8655697051026, 3871.399933010388, 3880.902977425587, 3884.1649045454797, 3886.2227554489214, 4396.670249731283, 4397.890052748707, 4434.445694288214, 4446.155230506193, 4487.932681009787, 5212.400573934046, 5217.50433708797, 5221.530062294411, 5223.425423203445, 5270.973645131749, 4404.295312750009, 4439.778011099496, 4443.466783985878, 4451.59935605797, 4495.797689103998, 4430.867073987785, 4597.057603191338, 4623.676342656049, 4648.2330415481065, 4670.346151538787, 4847.933454639973, 4854.95145048545, 4855.320255164209, 4855.635827312895, 4905.950940490549, 4971.577415919543, 5171.767270472763, 5182.429932707324, 5183.870403239949, 5239.47605239473, 4776.785044672929, 4825.662203645711, 4827.0, 4833.854984350475, 4866.148424025852, 5098.209777484496, 5129.9743501282255, 5130.204818253177, 5131.615128865425, 5182.53357197854, 5074.771635276347, 5108.182690769459, 5138.306328645585, 5172.870678233075, 5175.896482070413, 4986.426560945392, 4998.475160108136, 5026.271190677405, 5036.521530454601, 5076.314697515936, 5019.974900125622, 5039.319691841554, 5043.0, 5052.545270925487, 5094.898102038012, 4817.13291607514, 4866.8053277868485, 4896.730679812645, 4950.6782059166035, 4965.024141081786, 5018.548330650259, 5034.320366750589, 5043.167877300351, 5046.21783623539, 5074.035933172685, 4931.112399767932, 4940.357753492023, 4940.92588611164, 4943.0, 4985.401751789808], "value": 4735.0745536731465, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [542.9352620369334, 585.5169485174731, 587.7472686744701, 589.8260013296077, 602.8553147244661, 27098.86450567747, 40463.190736185294, 41285.380719289235, 41430.37854432186, 41506.16987660245, 41692.37461438081, 42489.7875510622, 42506.0, 42524.57475425245, 42536.787316063455, 7600.315971562558, 7740.612969351538, 7740.729074482394, 7778.611069446519, 7928.841423171533, 7674.040744906887, 9992.650257240997, 10179.94910025449, 10230.590776368974, 10593.099586535154, 10330.121939635103, 10391.584336626525, 10393.16854651626, 10401.0, 10407.739806504822, 7620.847583048363, 10017.649382271586, 10202.9489852551, 10214.029667181605, 10307.536160872742, 9841.311108222428, 10154.39073655583, 10158.542865571068, 10163.33938294016, 10163.94918025405, 39505.20989580221, 39905.80047099775, 39961.20077598461, 39997.80001100005, 40049.79975100135, 3125.718685318332, 3195.121341631047, 3309.8014119152685, 3443.9311213775586, 3490.8080055596934, 29123.708762912524, 29558.704412956024, 29905.850470747726, 29910.0, 31138.532922006187, 3374.088995971074, 3480.798342761527, 3532.982335088308, 3544.379733546619, 3597.478365636994, 264946.0, 265046.0, 267116.0, 267710.0, 269291.0, 31276.84361578223, 55370.0, 56027.71986140043, 56166.719166403906, 56191.15713264304, 32373.51439728406, 34281.0, 34309.0, 34345.14137146541, 34354.0, 12933.094683372261, 13118.0817342787, 13132.803007954888, 13142.4085916134, 13144.474221031243, 10340.793184136275, 11670.299782013106, 11733.530658773725, 11827.349495777642, 11945.163838531393, 7969.960150199212, 7986.560739159402, 8026.317762990095, 8048.798780030429, 8073.596320183968, 3106.8757249709756, 3120.9063728088195, 3133.3419981804077, 3154.4006638738565, 3193.5688682028094, 803.1085495100434, 810.7040930060485, 817.2807929022422, 925.3060204846231, 978.5205249427871, 27153.86423067872, 28133.71866281311, 28362.85818570894, 28424.573631395546, 28618.71381286202, 959.7427370145132, 995.0944640377367, 1019.3628981886321, 1021.6832781837654, 1061.2677252695769, 14211.78682319766, 14630.981022451515, 14815.481458148914, 14857.628559286104, 14982.850171498363, 385066.0, 385314.0, 386761.0, 386840.0, 388370.0, 50427.24359134616, 51146.48853511491, 51192.23211651828, 51299.743501283, 51317.23024154641, 1090.3621381491757, 1135.4266095621824, 1202.2606097249954, 1237.189640785287, 1251.2805137046234, 26448.0, 29291.56062659019, 29572.0, 29611.851940740158, 29902.401951961274, 48062.759686201345, 49721.25418118804, 49838.0, 54820.0, 54823.72588137034, 340133.0, 344582.0, 345174.0, 347295.0, 347487.0, 33337.83331083329, 37362.13189340576, 38623.78578891814, 39702.60297397104, 42229.78885105555, 41988.3701744468, 42593.14813703646, 42678.57321426746, 42778.57221427746, 43898.0, 35921.46117808183, 36505.63494365022, 37386.81306593558, 37714.245715086094, 37837.43243851399, 36939.44590831086, 37039.81480092582, 37532.0, 37549.62450375571, 37877.81061094677, 35795.284094318486, 36505.63494365022, 36527.817360913024, 37179.6282037187, 37329.81335093307, 32352.72131049491, 33714.494282586274, 33774.0, 33813.66186338105, 34041.48937765985, 24892.0, 25335.239942801745, 25417.237482874803, 25531.744682552937, 25845.0], "value": 17486.063549426763, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.56378909098186, 372.78005976473884, 372.93473642112633, 386.57090629401375, 386.9961300386995, 16349.673006539877, 16845.410410635646, 17076.060816655096, 17301.0, 17358.305667773304, 15824.208789560533, 16651.167441627902, 17090.401835935743, 17110.401135960245, 17130.914345428286, 5041.747912604374, 5207.375114986207, 5250.159974404096, 5250.947490525104, 5253.579713622901, 3737.1965027519077, 3930.8231129599235, 5163.870903227431, 5797.65214087154, 6154.753809847601, 6217.689115544227, 6221.191245138126, 6229.096780966757, 6239.251289845225, 6246.906296405557, 6006.849828754294, 6049.727762250709, 6119.847003824895, 6169.845753856144, 6182.103594978703, 3387.61042480113, 4930.580900623451, 5271.077561426773, 5278.313819203479, 5435.83692489226, 19650.80349196504, 20388.79611203899, 20406.285779997776, 20700.171993120257, 20719.482012949647, 1959.2358979997812, 2109.7362829646295, 2112.176251262009, 2537.4544472938405, 2585.4958283134797, 13385.196888186643, 13411.664708382272, 13457.327133643279, 13583.52457663977, 13629.386677599532, 1732.2724455728624, 1793.8833975791663, 1807.1777341309673, 1874.4376686993983, 1876.418310323804, 64235.35764642387, 66790.3320966789, 67456.0, 67517.0, 68266.3173368265, 8899.822003559893, 8929.374943753875, 9106.767097680227, 9635.084666956767, 9920.652777152909, 12963.935180324039, 13041.608751737464, 13071.673208169872, 13080.345982700826, 13092.0, 7328.377087947478, 7375.88936165958, 7468.365188958999, 7563.773086807405, 7588.506747061423, 7230.240824713329, 7270.200277969419, 7315.963420182865, 7393.593352365564, 7410.184879663233, 5878.61896591058, 5956.8808623828145, 5958.046712526062, 6033.698315084228, 6143.32423433422, 1643.334449547935, 1677.2200926569203, 1731.904745239024, 1786.4640607817603, 1816.2008716164846, 806.6087947345533, 834.9373796965252, 867.6876324523166, 887.6493784955036, 891.4562117108559, 16918.238679259463, 17066.146692665316, 17420.303187872596, 17537.91231043862, 17613.119344032748, 856.6102423397339, 879.2570278114982, 940.5015341868684, 945.8297506448905, 951.296040929707, 9409.0, 9863.210943124677, 10060.748481288027, 10123.088921996909, 10159.593616255266, 353865.0, 360932.0, 363951.0, 363968.0, 365498.0, 62823.0, 62955.68522157452, 64146.35853641404, 65262.673686631264, 65373.0, 873.7204094689765, 876.1414690719167, 904.3759805734154, 905.8188362327561, 906.8095699902963, 15250.77123843121, 15327.846721533087, 15537.84462155364, 15546.0, 15868.0, 34069.829650851585, 34444.82777586096, 34482.82758586191, 34531.30937381289, 34755.30489390249, 44910.32634510419, 44991.32513012373, 45151.54848451474, 45301.320480193484, 45817.08365832598, 7661.1572726998875, 7780.766577002699, 7824.687012519663, 7892.723754668788, 7951.08562515295, 11715.355655439032, 11915.404229788302, 12067.879321207027, 12095.274283543016, 12165.513379464723, 10006.399616023062, 10346.430946298025, 10373.0, 10452.32059916103, 10596.0, 4599.724016559017, 5482.862928426821, 10369.222308326755, 10522.31604945676, 10703.946480267548, 10297.74255643615, 10581.62964296246, 10644.254902156774, 10755.354678719303, 10793.514291856729, 7632.122305934889, 7794.610269486617, 7815.179406162271, 7843.882341764764, 7976.122626511195, 10563.735906602396, 10596.47017649099, 10661.200409969439, 10673.0, 10717.035466808025], "value": 8312.650575661248, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1285.9421326040326, 1381.0401770769315, 1426.3795249066654, 1484.4062375049978, 1701.2089378439023, 6699.832504187391, 7544.0, 7829.138794732575, 7834.843303133941, 8005.959970200155, 7786.104597971235, 7953.244441778036, 7972.083210430802, 7977.800554986128, 7986.680532778696, 1853.4439668099583, 1906.256559941624, 1907.3324336482258, 2220.5780901628677, 2251.4371407148215, 1923.3941308487852, 2127.6489379252403, 2225.543763528473, 2232.486528098538, 2239.992003598379, 2197.7362716474045, 2215.678726584644, 2216.5345277491665, 2231.0852550454315, 2239.1491233331394, 1834.5597056706429, 2198.9560208795815, 2210.193279452988, 2220.411590928405, 2228.22012295696, 2165.8808765517892, 2231.8102961248314, 2232.631615783394, 2243.349428665685, 2248.7976082152522, 7773.961130194313, 7821.335186509154, 7827.804304892366, 7832.0, 7854.0, 4532.79602417892, 4691.859244222679, 4695.436547614274, 4700.4359476862655, 4700.5064468230685, 2841.3322869125946, 2842.7157284271616, 2893.8408387538675, 3040.802347847383, 3103.3482968576627, 989.7723523589543, 991.8016396720685, 1020.3469779341227, 1064.6539874540729, 1067.2902519824308, 10578.312409693346, 10785.514651840685, 10847.783044339149, 10849.077828384598, 10849.403282819441, 4100.466939297872, 4172.102997855475, 4246.49042114942, 4248.936265956013, 4250.957490425056, 9306.069393060776, 9368.953155234316, 9374.343795934219, 9377.953110234404, 9380.5309734513, 4662.463816661128, 4669.066186762593, 4676.111538807616, 4680.157571637138, 4680.180968330596, 3727.664510194041, 3787.280416720814, 4105.651019663303, 4122.6083522065355, 4142.440770495945, 3661.56061272649, 3763.510743603314, 3802.923941521154, 3808.0479880029993, 3809.485719427897, 1164.394514852289, 1173.6831055614937, 1189.1972918280126, 1207.2937331661076, 1211.9697007574882, 777.7122464687989, 855.4653341661461, 887.2236792806294, 899.3704406915185, 906.3972458315146, 5515.4760297771645, 5525.917111243334, 5532.944670553324, 5543.667379957215, 5755.597108202385, 834.3742193354984, 883.6112110671284, 905.6467977488785, 915.2220612479339, 935.9578818953163, 3760.605136460687, 3772.264408440383, 3819.5416550014174, 3881.8835434936996, 3891.630295121959, 9419.858702119336, 9488.240940724725, 9728.708138755848, 9732.951335243279, 9836.065573770624, 9532.761680957892, 9627.56675949584, 9634.0, 9646.517674116267, 9694.709158725249, 7178.102737157856, 7185.389241914496, 7238.493305468672, 7335.669894854637, 7342.412606991428, 5434.212039254365, 5562.833115006556, 5600.943990560042, 5620.662760234399, 5864.794732184353, 8709.259712924473, 8836.381453298207, 9073.727788166101, 9076.636934522545, 9118.452892826452, 8679.696210632597, 9061.22979546746, 9083.227925626132, 9113.36206465541, 9209.079092090737, 5967.8209653710455, 6157.84605384869, 6172.290186628596, 6874.140732408449, 7041.753538626123, 6953.096097507291, 7283.2352602975925, 7514.812129696801, 7558.962205188939, 7702.961485192538, 6772.627505487246, 6885.311468853275, 6924.3421874921805, 7023.086998690138, 7024.438044956289, 6752.0, 6833.692483838338, 6834.111565496453, 6880.621565813928, 6962.23415424313, 6201.472874805692, 6418.390252925965, 6506.869862602816, 6514.902276465762, 6520.9347906520325, 4884.145274576864, 4922.4339200992345, 4927.113119638356, 4960.3630801836025, 4977.9502204978935, 4847.878803029811, 4895.167821470287, 4927.975360123177, 4931.654784165074, 4967.478414766398], "value": 4203.355566473026, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.6274900497885, 305.43189667218974, 312.0404755377215, 315.4810336995641, 317.8140787639231, 4631.564215093324, 4875.219964805632, 4882.340883980662, 4937.703737775736, 4981.576565991895, 4633.90732185357, 4796.736179510125, 4806.783694733736, 4819.662623616348, 4892.730899800509, 3896.6687831534214, 3897.47384103146, 3904.7852368119884, 3906.8437262509606, 3914.8042597869994, 3679.5952445231005, 3687.2072504411544, 3852.5184351956004, 3873.360895452261, 3909.569947305794, 3807.5240594925635, 3832.8083595820235, 3833.4249862520564, 3851.8844434667003, 3857.1514266861245, 3804.695624350059, 3829.272438236726, 3873.438351439054, 3874.3219936511, 3907.1404291056206, 3471.8784842530645, 3496.4755286707195, 3499.8075105869166, 3501.0897166736577, 3513.664807373207, 4568.5431456854385, 4761.666683332168, 4777.256301449946, 4781.330613714083, 4783.210770222909, 4339.7396156230725, 4345.109252603241, 4385.3641222022625, 4436.64506839452, 4455.398521199629, 4911.263310503417, 5005.649604527648, 5052.0, 5083.186690129599, 5087.618428617869, 3654.835532401048, 3664.706823454117, 3665.3402387570227, 3666.926661466782, 3677.724170687209, 5371.973140134274, 5381.408045115034, 5384.9730751346, 5408.729563521808, 5415.83752487422, 3706.5737440194184, 3708.49935258742, 3712.090537818198, 3718.0, 3718.1262403335195, 3619.692326152254, 3773.509443772292, 3792.58281589025, 3805.1818858945458, 3811.942820857689, 4301.419308393327, 4306.729514793144, 4316.935245971313, 4330.372096046056, 4334.869953901388, 5076.670016448919, 5080.161773307437, 5080.644354895196, 5097.439281679012, 5109.284700141983, 1234.1854376111723, 1248.2759999200441, 1275.2284867655121, 1283.4224598930518, 1327.9468821247235, 820.2248874813245, 844.932405407566, 847.3856454070749, 851.012884913721, 855.9358048146414, 3991.4212439196153, 4003.979980100139, 4021.828212765133, 4043.8786836394956, 4075.449814275094, 4625.352450656911, 4638.698484598491, 4652.581267685924, 4656.0, 4745.549172828576, 3917.216556688674, 3940.4680368150507, 3955.20895820837, 3974.3044967130636, 3987.4616926715103, 2325.976740232576, 2488.5645012122804, 2508.548461276951, 2526.608375701769, 2527.4186937004592, 4420.226460369422, 4448.510663826976, 4454.28731402974, 4459.375687403766, 4461.7730124216105, 4785.473597904228, 4796.736179510161, 4800.759962001886, 4821.0, 4823.710577365369, 4451.221036318631, 4458.71018383804, 4587.839425620154, 5015.0, 5026.2460630904925, 5233.241180028951, 5243.5018673227505, 5272.604554658339, 5325.7337133143965, 5344.5991550634635, 5205.557527610044, 5210.218467229945, 5261.158214685632, 5269.419174247787, 5283.679080229943, 4738.928916066331, 4998.875028124326, 5009.674371165863, 5009.899802004013, 5015.1975683890405, 3705.9444108338935, 3724.832382542738, 3736.4021756519915, 3739.3546839390583, 3751.6811071059265, 5014.4484106747495, 5208.8437346879655, 5253.527182553588, 5289.920651190158, 5360.0887849064975, 4905.754712264301, 5060.645754797276, 5084.618653600921, 5100.2349647553165, 5109.20807274873, 5096.159133742891, 5098.923516147335, 5100.69395836251, 5109.131447653834, 5122.154844450624, 4934.901301974012, 5022.271770593316, 5025.974870125772, 5027.472115427828, 5039.773210205476, 5105.540501354896, 5122.206058060858, 5147.150720131136, 5156.510131537498, 5168.483151684802, 5067.467915868928, 5069.0, 5075.670081444694, 5076.0, 5076.847694569169], "value": 3783.0082109771884, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [674.4840197249102, 677.9864402711946, 713.7046261036219, 716.2228981555013, 741.6921977379387, 12760.680982975431, 13336.866631333683, 13496.257705826176, 13509.864901350984, 13524.459021639148, 14321.140731556114, 14884.925575372135, 14900.776488352656, 14902.776458353133, 15468.922655386736, 634.5336177909234, 766.2452484302958, 768.3046842607449, 807.628490894188, 814.8207394373258, 786.4455558831011, 809.6963638635511, 813.7680760983121, 814.4217605500102, 821.5194111444812, 829.1128492513013, 835.5613303015905, 837.2464781696461, 839.093778718985, 839.8824164616958, 655.9573627714183, 805.8227190018187, 834.5451728807784, 834.8789425533324, 835.0730688935276, 605.7546693589103, 608.5162295974711, 608.5739982012609, 610.0, 610.6031079798122, 14181.78727319091, 14233.928830355886, 14260.144391336553, 14261.28693565328, 14394.496192633313, 12928.28894410807, 13430.19418834873, 13625.659358516017, 13658.317533180241, 13854.65363365924, 12532.498700051987, 12598.874011259863, 12750.426230819543, 12796.232226066373, 13031.543895963596, 4134.896627584334, 4164.708470407073, 4174.728642638219, 4181.226473102486, 4257.467816522934, 65681.343186568, 65788.3421165787, 65896.3410365895, 65988.67005664941, 66254.66872665654, 10523.421211833424, 10570.735731606772, 10573.312734672221, 10812.56749730002, 11200.887991120147, 20399.79600203979, 20675.069621867053, 20691.379258622266, 20723.689144662843, 20757.0, 6784.423324017415, 6828.0, 6876.243613202544, 6929.237783843773, 6953.89569156463, 3794.1842503861803, 3841.5966323536186, 3860.0542866997766, 3874.4575759393706, 3929.941050884239, 2939.8236105833716, 3036.028470889294, 3040.1791516290477, 3062.1885200421907, 3068.831214283191, 525.461402062881, 532.6777299733606, 542.0432935868196, 543.4782608695697, 545.1849485019842, 538.5530010091614, 546.546366515791, 558.8574913397058, 573.7475510775246, 587.6943989125631, 7579.772606821804, 7596.8480630387085, 7664.73173438927, 7932.960335198287, 8078.071021832565, 547.4252035362853, 561.3208018297905, 562.6961440821992, 567.6764244380663, 581.0, 3877.2051729395407, 3880.72933008612, 3986.0832008638176, 4024.879253622396, 4072.3687828386646, 107206.0, 108039.0, 109004.0, 112070.43964780286, 112402.43798780954, 78236.0, 81772.59113704393, 81844.0, 82357.0, 82581.0, 61026.084608730904, 63211.68394158, 77601.61199194081, 81771.02279805655, 83824.58087709645, 8429.325653947546, 8553.914460855312, 8590.484570925764, 8910.55447227623, 8964.462132272085, 41276.58723412728, 41775.7911210442, 42194.0, 42450.0, 43508.0, 19945.601087978448, 19964.3012494562, 22518.0, 45123.64629061134, 58236.70881645734, 11367.147463940073, 11369.772604548029, 11546.249493782878, 11937.701557461132, 11940.641780746591, 12727.745445091232, 12752.87247127554, 12764.042696797964, 13459.865401346253, 13911.115970696716, 12434.129610927148, 12729.172603780724, 12987.610371688865, 13020.47918083266, 13474.607379187857, 11125.221234513507, 11568.88431115678, 11612.303261803982, 12266.0, 12286.0, 11378.943105284421, 11823.704407389883, 12056.457459414172, 12136.514539418324, 12432.937835310766, 9921.702348929544, 10627.574897004033, 10806.891931080903, 10855.294405863593, 10943.562257509611, 9944.35361701516, 10031.498425078571, 10234.437105959243, 10766.246362754531, 10869.67390978272], "value": 6698.175697188062, "unit": "score"}], "name": "dromaeo_css", "value": 6469.432985664425, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 107.0, 114.0, 114.0, 113.0, 112.0, 112.0, 113.0, 111.0, 112.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 129.0, 141.0, 185.0, 131.0, 161.0, 155.0, 131.0, 191.0, 131.0], "value": 151.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 161.0, 162.0, 162.0, 161.0, 162.0, 161.0, 160.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 110.0, 76.0, 76.0, 80.0, 75.0, 97.0, 74.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 117.0, 86.0, 85.0, 86.0, 123.0, 85.0, 86.0, 133.0], "value": 97.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 147.0, 146.0, 147.0, 147.0, 147.0, 148.0, 146.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 65.0, 66.0, 64.0, 65.0, 65.0, 64.0, 65.0], "value": 64.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 66.0, 64.0, 65.0, 65.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 83.0, 84.0, 83.0, 82.0, 85.0, 84.0, 90.0, 121.0, 83.0], "value": 88.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 143.0, 130.0, 130.0, 134.0, 133.0, 129.0, 135.0, 134.0, 142.0], "value": 134.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 172.0, 172.0, 171.0, 171.0, 174.0, 167.0, 174.0, 169.0, 166.0], "value": 171.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 71.0, 70.0, 67.0, 75.0, 66.0, 67.0, 66.0, 66.0], "value": 68.2, "unit": "score"}], "name": "kraken", "value": 1554.9, "alertThreshold": 2.0}]} 01:39:43 INFO - Return code: 0 01:39:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:39:43 INFO - # TBPL SUCCESS # 01:39:43 INFO - Running post-action listener: _resource_record_post_action 01:39:43 INFO - ##### 01:39:43 INFO - ##### Finished run-tests step (success) 01:39:43 INFO - ##### 01:39:43 INFO - Running post-run listener: _resource_record_post_run 01:39:43 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 543526912; Read time: 16; Write time: 578212 01:39:43 INFO - TinderboxPrint: CPU usage
13.2% 01:39:43 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 01:39:43 INFO - TinderboxPrint: I/O write bytes / time
543,526,912 / 578,212 01:39:43 INFO - TinderboxPrint: CPU idle
8,323.9 (86.8%) 01:39:43 INFO - TinderboxPrint: CPU user
1,217.9 (12.7%) 01:39:43 INFO - TinderboxPrint: Swap in / out
0 / 0 01:39:43 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 255471616; Read time: 0; Write time: 337036 01:39:43 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288055296; Read time: 16; Write time: 241176 01:39:43 INFO - Running post-run listener: _upload_blobber_files 01:39:43 INFO - Blob upload gear active. 01:39:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:39:43 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 01:39:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:39:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:39:44 INFO - (blobuploader) - INFO - Open directory for files ... 01:39:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:39:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:39:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:39:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:39:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:39:45 INFO - (blobuploader) - INFO - Done attempting. 01:39:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:39:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:39:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:39:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:39:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:39:48 INFO - (blobuploader) - INFO - Done attempting. 01:39:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:39:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:39:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:39:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:39:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:39:48 INFO - (blobuploader) - INFO - Done attempting. 01:39:48 INFO - (blobuploader) - INFO - Iteration through files over. 01:39:48 INFO - Return code: 0 01:39:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:39:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:39:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/043694949226f43eae46a13947bfd11398236dcd0acbded6f1f7f89b6e4d14eb86a816634e35e2983fddcae4af46260fd0bc2b4a88b1147427229d2162da6b42", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6a83cad7958cc9a55fe9ee77c1aa11cac9d8eb5ae0094fea348494bd38711571dcd32b16b4ec5afdb098f73bfb3d147f191a0f9b83e4d7c311897defae429380", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c51a39eb70ec3b5989ae239764c613a32b3595c20989a0433647104965cabfac92370d378d6d6dc6c0a6aeb035755db3436866e82f2a0198319f452d0e624b05"} 01:39:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:39:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:39:48 INFO - Contents: 01:39:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/043694949226f43eae46a13947bfd11398236dcd0acbded6f1f7f89b6e4d14eb86a816634e35e2983fddcae4af46260fd0bc2b4a88b1147427229d2162da6b42", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6a83cad7958cc9a55fe9ee77c1aa11cac9d8eb5ae0094fea348494bd38711571dcd32b16b4ec5afdb098f73bfb3d147f191a0f9b83e4d7c311897defae429380", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c51a39eb70ec3b5989ae239764c613a32b3595c20989a0433647104965cabfac92370d378d6d6dc6c0a6aeb035755db3436866e82f2a0198319f452d0e624b05"} 01:39:48 INFO - Running post-run listener: copy_logs_to_upload_dir 01:39:48 INFO - Copying logs to upload dir... 01:39:48 INFO - mkdir: /builds/slave/test/build/upload/logs 01:39:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.074155 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-22 01:39:48.512760) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 01:39:48.517138) ========= 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=cbe409c6de289db6ac707de3000001d4-1466583454.983663-1088127833 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/043694949226f43eae46a13947bfd11398236dcd0acbded6f1f7f89b6e4d14eb86a816634e35e2983fddcae4af46260fd0bc2b4a88b1147427229d2162da6b42", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6a83cad7958cc9a55fe9ee77c1aa11cac9d8eb5ae0094fea348494bd38711571dcd32b16b4ec5afdb098f73bfb3d147f191a0f9b83e4d7c311897defae429380", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c51a39eb70ec3b5989ae239764c613a32b3595c20989a0433647104965cabfac92370d378d6d6dc6c0a6aeb035755db3436866e82f2a0198319f452d0e624b05"} build_url:https://queue.taskcluster.net/v1/task/EUpwcNOCQtWHgtJJCTTbsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011168 build_url: 'https://queue.taskcluster.net/v1/task/EUpwcNOCQtWHgtJJCTTbsw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/043694949226f43eae46a13947bfd11398236dcd0acbded6f1f7f89b6e4d14eb86a816634e35e2983fddcae4af46260fd0bc2b4a88b1147427229d2162da6b42", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6a83cad7958cc9a55fe9ee77c1aa11cac9d8eb5ae0094fea348494bd38711571dcd32b16b4ec5afdb098f73bfb3d147f191a0f9b83e4d7c311897defae429380", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c51a39eb70ec3b5989ae239764c613a32b3595c20989a0433647104965cabfac92370d378d6d6dc6c0a6aeb035755db3436866e82f2a0198319f452d0e624b05"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 01:39:48.547925) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 01:39:48.548785) ========= 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=cbe409c6de289db6ac707de3000001d4-1466583454.983663-1088127833 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004517 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 01:39:48.630441) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 01:39:48.630795) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 01:39:48.631153) ========= ========= Total master_lag: 0.19 =========