builder: larch_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-020 starttime: 1467223223.77 results: success (0) buildid: 20160629092027 builduid: a3b52b2ddcde40418738a117800d63f1 revision: 053b0f43de1f6c52af2ab2187e4d0a11f453a7d4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 11:00:23.766952) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 11:00:23.767435) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 11:00:23.767736) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 11:00:23.816313) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 11:00:23.816723) ========= 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=af724c981e2a0f424dbabf99000001e7-1467223223.290504-140936659 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-29 11:00:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.3M=0s 2016-06-29 11:00:24 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.087722 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 11:00:23.919216) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 11:00:23.919550) ========= 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=af724c981e2a0f424dbabf99000001e7-1467223223.290504-140936659 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023243 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 11:00:23.969363) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 11:00:23.969733) ========= bash -c 'python archiver_client.py mozharness --repo projects/larch --rev 053b0f43de1f6c52af2ab2187e4d0a11f453a7d4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/larch --rev 053b0f43de1f6c52af2ab2187e4d0a11f453a7d4 --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=af724c981e2a0f424dbabf99000001e7-1467223223.290504-140936659 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-29 11:00:24,467 truncating revision to first 12 chars 2016-06-29 11:00:24,467 Setting DEBUG logging. 2016-06-29 11:00:24,467 attempt 1/10 2016-06-29 11:00:24,467 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/larch/053b0f43de1f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-29 11:00:24,852 unpacking tar archive at: larch-053b0f43de1f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.720531 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 11:00:24.703790) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 11:00:24.704117) ========= script_repo_revision: 053b0f43de1f6c52af2ab2187e4d0a11f453a7d4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 11:00:24.704553) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 11:00:24.704871) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 11:00:24.716160) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-06-29 11:00:24.716575) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Larch-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch-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', 'Larch-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Larch-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=af724c981e2a0f424dbabf99000001e7-1467223223.290504-140936659 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:00:25 INFO - MultiFileLogger online at 20160629 11:00:25 in /builds/slave/test 11:00:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Larch-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch-Non-PGO 11:00:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:00:25 INFO - {'append_to_log': False, 11:00:25 INFO - 'base_work_dir': '/builds/slave/test', 11:00:25 INFO - 'blob_upload_branch': 'Larch-Non-PGO', 11:00:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:00:25 INFO - 'branch': 'Larch-Non-PGO', 11:00:25 INFO - 'buildbot_json_path': 'buildprops.json', 11:00:25 INFO - 'config_files': ('talos/linux_config.py',), 11:00:25 INFO - 'default_actions': ('clobber', 11:00:25 INFO - 'read-buildbot-config', 11:00:25 INFO - 'download-and-extract', 11:00:25 INFO - 'populate-webroot', 11:00:25 INFO - 'create-virtualenv', 11:00:25 INFO - 'install', 11:00:25 INFO - 'run-tests'), 11:00:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:00:25 INFO - 'download_minidump_stackwalk': True, 11:00:25 INFO - 'download_symbols': 'ondemand', 11:00:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:00:25 INFO - 'tooltool.py': '/tools/tooltool.py', 11:00:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:00:25 INFO - '/tools/misc-python/virtualenv.py')}, 11:00:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:00:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:00:25 INFO - 'installer_path': 'installer.exe', 11:00:25 INFO - 'log_level': 'info', 11:00:25 INFO - 'log_name': 'talos', 11:00:25 INFO - 'log_to_console': True, 11:00:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:00:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:00:25 INFO - 'opt_config_files': (), 11:00:25 INFO - 'pip_index': False, 11:00:25 INFO - 'sps_profile': False, 11:00:25 INFO - 'sps_profile_interval': 0, 11:00:25 INFO - 'suite': 'dromaeojs', 11:00:25 INFO - 'system_bits': '32', 11:00:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:00:25 INFO - 'title': 'talos-linux64-ix-020', 11:00:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:00:25 INFO - 'use_talos_json': True, 11:00:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:00:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:00:25 INFO - 'work_dir': 'build'} 11:00:25 INFO - ##### 11:00:25 INFO - ##### Running clobber step. 11:00:25 INFO - ##### 11:00:25 INFO - Running pre-action listener: _resource_record_pre_action 11:00:25 INFO - Running main action method: clobber 11:00:25 INFO - rmtree: /builds/slave/test/build 11:00:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:00:25 INFO - Running post-action listener: _resource_record_post_action 11:00:25 INFO - ##### 11:00:25 INFO - ##### Running read-buildbot-config step. 11:00:25 INFO - ##### 11:00:25 INFO - Running pre-action listener: _resource_record_pre_action 11:00:25 INFO - Running main action method: read_buildbot_config 11:00:25 INFO - Using buildbot properties: 11:00:25 INFO - { 11:00:25 INFO - "project": "", 11:00:25 INFO - "product": "firefox", 11:00:25 INFO - "script_repo_revision": "production", 11:00:25 INFO - "builddir": "larch_ubuntu64_hw_test-dromaeojs", 11:00:25 INFO - "repository": "", 11:00:25 INFO - "buildername": "Ubuntu HW 12.04 x64 larch talos dromaeojs", 11:00:25 INFO - "buildid": "20160629092027", 11:00:25 INFO - "pgo_build": "False", 11:00:25 INFO - "basedir": "/builds/slave/test", 11:00:25 INFO - "buildnumber": 0, 11:00:25 INFO - "slavename": "talos-linux64-ix-020", 11:00:25 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:00:25 INFO - "platform": "ubuntu64_hw", 11:00:25 INFO - "scheduler": "tests-larch-linux64-talos", 11:00:25 INFO - "branch": "larch", 11:00:25 INFO - "repo_path": "projects/larch", 11:00:25 INFO - "revision": "053b0f43de1f6c52af2ab2187e4d0a11f453a7d4", 11:00:25 INFO - "stage_platform": "linux64", 11:00:25 INFO - "builduid": "a3b52b2ddcde40418738a117800d63f1", 11:00:25 INFO - "slavebuilddir": "test" 11:00:25 INFO - } 11:00:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.tar.bz2. 11:00:25 INFO - Running post-action listener: _resource_record_post_action 11:00:25 INFO - ##### 11:00:25 INFO - ##### Running download-and-extract step. 11:00:25 INFO - ##### 11:00:25 INFO - Running pre-action listener: _resource_record_pre_action 11:00:25 INFO - Running main action method: download_and_extract 11:00:25 INFO - mkdir: /builds/slave/test/build/tests 11:00: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')]} 11:00:25 INFO - https://queue.taskcluster.net/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:00:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.test_packages.json 11:00:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.test_packages.json 11:00:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-47.0.2.en-US.linux-x86_64.test_packages.json 11:00:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.2.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:00:26 INFO - Downloaded 1448 bytes. 11:00:26 INFO - Reading from file /builds/slave/test/build/firefox-47.0.2.en-US.linux-x86_64.test_packages.json 11:00:26 INFO - Using the following test package requirements: 11:00:26 INFO - {u'common': [u'firefox-47.0.2.en-US.linux-x86_64.common.tests.zip'], 11:00:26 INFO - u'cppunittest': [u'firefox-47.0.2.en-US.linux-x86_64.common.tests.zip', 11:00:26 INFO - u'firefox-47.0.2.en-US.linux-x86_64.cppunittest.tests.zip'], 11:00:26 INFO - u'gtest': [u'firefox-47.0.2.en-US.linux-x86_64.common.tests.zip', 11:00:26 INFO - u'firefox-47.0.2.en-US.linux-x86_64.gtest.tests.zip'], 11:00:26 INFO - u'jittest': [u'firefox-47.0.2.en-US.linux-x86_64.common.tests.zip', 11:00:26 INFO - u'jsshell-linux-x86_64.zip'], 11:00:26 INFO - u'mochitest': [u'firefox-47.0.2.en-US.linux-x86_64.common.tests.zip', 11:00:26 INFO - u'firefox-47.0.2.en-US.linux-x86_64.mochitest.tests.zip'], 11:00:26 INFO - u'mozbase': [u'firefox-47.0.2.en-US.linux-x86_64.common.tests.zip'], 11:00:26 INFO - u'reftest': [u'firefox-47.0.2.en-US.linux-x86_64.common.tests.zip', 11:00:26 INFO - u'firefox-47.0.2.en-US.linux-x86_64.reftest.tests.zip'], 11:00:26 INFO - u'talos': [u'firefox-47.0.2.en-US.linux-x86_64.common.tests.zip', 11:00:26 INFO - u'firefox-47.0.2.en-US.linux-x86_64.talos.tests.zip'], 11:00:26 INFO - u'web-platform': [u'firefox-47.0.2.en-US.linux-x86_64.common.tests.zip', 11:00:26 INFO - u'firefox-47.0.2.en-US.linux-x86_64.web-platform.tests.zip'], 11:00:26 INFO - u'webapprt': [u'firefox-47.0.2.en-US.linux-x86_64.common.tests.zip'], 11:00:26 INFO - u'xpcshell': [u'firefox-47.0.2.en-US.linux-x86_64.common.tests.zip', 11:00:26 INFO - u'firefox-47.0.2.en-US.linux-x86_64.xpcshell.tests.zip']} 11:00:26 INFO - Downloading packages: [u'firefox-47.0.2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:00:26 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')]} 11:00:26 INFO - https://queue.taskcluster.net/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:00:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.common.tests.zip 11:00:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.common.tests.zip 11:00:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.2.en-US.linux-x86_64.common.tests.zip 11:00:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:00:27 INFO - Downloaded 22140718 bytes. 11:00:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:00:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:00:28 INFO - Return code: 0 11:00:28 INFO - Downloading packages: [u'firefox-47.0.2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0.2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:00:28 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')]} 11:00:28 INFO - https://queue.taskcluster.net/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:00:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.common.tests.zip 11:00:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.common.tests.zip 11:00:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0.2.en-US.linux-x86_64.common.tests.zip 11:00:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:00:29 INFO - Downloaded 22140718 bytes. 11:00:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:00:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:00:31 INFO - Return code: 0 11:00:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:00:31 INFO - https://queue.taskcluster.net/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:00:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.talos.tests.zip 11:00:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.talos.tests.zip 11:00:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0.2.en-US.linux-x86_64.talos.tests.zip 11:00:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:00:32 INFO - Downloaded 10845194 bytes. 11:00:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:00:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:00:32 INFO - Return code: 0 11:00: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')]} 11:00:32 INFO - https://queue.taskcluster.net/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:00:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.tar.bz2 11:00:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.tar.bz2 11:00:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0.2.en-US.linux-x86_64.tar.bz2 11:00:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0.2.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:00:34 INFO - Downloaded 59008279 bytes. 11:00:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.tar.bz2 11:00:34 INFO - mkdir: /builds/slave/test/properties 11:00:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:00:34 INFO - Writing to file /builds/slave/test/properties/build_url 11:00:34 INFO - Contents: 11:00:34 INFO - build_url:https://queue.taskcluster.net/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.tar.bz2 11:00:34 INFO - Running post-action listener: _resource_record_post_action 11:00:34 INFO - Running post-action listener: set_extra_try_arguments 11:00:34 INFO - ##### 11:00:34 INFO - ##### Running populate-webroot step. 11:00:34 INFO - ##### 11:00:34 INFO - Running pre-action listener: _resource_record_pre_action 11:00:34 INFO - Running main action method: populate_webroot 11:00:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:00:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:00:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:00:34 INFO - '--tppagecycles', 11:00:34 INFO - '7'], 11:00:34 INFO - 'tests': ['tsvgm']}}, 11:00:34 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:00:34 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:00:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:00:34 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 11:00:34 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:00:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:00:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:00:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:34 INFO - 'talos_options': ['--e10s'], 11:00:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:00:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:34 INFO - 'tests': ['damp', 'tps']}, 11:00:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:34 INFO - 'talos_options': ['--e10s'], 11:00:34 INFO - 'tests': ['damp', 'tps']}, 11:00:34 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:00:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:00:34 INFO - 'other': {'tests': ['a11yr', 11:00:34 INFO - 'ts_paint', 11:00:34 INFO - 'tpaint', 11:00:34 INFO - 'sessionrestore', 11:00:34 INFO - 'sessionrestore_no_auto_restore', 11:00:34 INFO - 'tabpaint']}, 11:00:34 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:00:34 INFO - 'tests': ['a11yr', 11:00:34 INFO - 'ts_paint', 11:00:34 INFO - 'tpaint', 11:00:34 INFO - 'sessionrestore', 11:00:34 INFO - 'sessionrestore_no_auto_restore', 11:00:34 INFO - 'tabpaint']}, 11:00:34 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:00:34 INFO - 'tests': ['a11yr', 11:00:34 INFO - 'ts_paint', 11:00:34 INFO - 'tpaint', 11:00:34 INFO - 'sessionrestore', 11:00:34 INFO - 'sessionrestore_no_auto_restore', 11:00:34 INFO - 'tabpaint']}, 11:00:34 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:00:34 INFO - 'tests': ['a11yr', 11:00:34 INFO - 'ts_paint', 11:00:34 INFO - 'tpaint', 11:00:34 INFO - 'sessionrestore', 11:00:34 INFO - 'sessionrestore_no_auto_restore', 11:00:34 INFO - 'tabpaint']}, 11:00:34 INFO - 'other_l64': {'tests': ['a11yr', 11:00:34 INFO - 'ts_paint', 11:00:34 INFO - 'tpaint', 11:00:34 INFO - 'sessionrestore', 11:00:34 INFO - 'sessionrestore_no_auto_restore', 11:00:34 INFO - 'tabpaint']}, 11:00:34 INFO - 'other_nol64': {'tests': ['a11yr', 11:00:34 INFO - 'ts_paint', 11:00:34 INFO - 'tpaint', 11:00:34 INFO - 'sessionrestore', 11:00:34 INFO - 'sessionrestore_no_auto_restore', 11:00:34 INFO - 'tabpaint']}, 11:00:34 INFO - 'svgr': {'tests': ['tsvgx', 11:00:34 INFO - 'tsvgr_opacity', 11:00:34 INFO - 'tart', 11:00:34 INFO - 'tscrollx', 11:00:34 INFO - 'cart']}, 11:00:34 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:00:34 INFO - 'tests': ['tsvgx', 11:00:34 INFO - 'tsvgr_opacity', 11:00:34 INFO - 'tart', 11:00:34 INFO - 'tscrollx', 11:00:34 INFO - 'cart']}, 11:00:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:34 INFO - 'tests': ['tp5o']}, 11:00:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:34 INFO - 'talos_options': ['--e10s'], 11:00:34 INFO - 'tests': ['tp5o']}, 11:00:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:34 INFO - 'talos_options': ['--xperf_path', 11:00:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:00:34 INFO - 'tests': ['tp5n']}, 11:00:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:00:34 INFO - 'talos_options': ['--e10s', 11:00:34 INFO - '--xperf_path', 11:00:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:00:34 INFO - 'tests': ['tp5n']}}, 11:00:34 INFO - 'talos.zip': {'path': '', 11:00:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:00:34 INFO - Running post-action listener: _resource_record_post_action 11:00:34 INFO - ##### 11:00:34 INFO - ##### Running create-virtualenv step. 11:00:34 INFO - ##### 11:00:34 INFO - Running pre-action listener: _resource_record_pre_action 11:00:34 INFO - Running main action method: create_virtualenv 11:00:34 INFO - Creating virtualenv /builds/slave/test/build/venv 11:00:34 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 11:00:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:00:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:00:34 INFO - Using real prefix '/usr' 11:00:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:00:35 INFO - Installing distribute.............................................................................................................................................................................................done. 11:00:37 INFO - Installing pip.................done. 11:00:37 INFO - Return code: 0 11:00:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:00:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:00:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:00:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:37 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 0x7f872711df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c43410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cd2160>, '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 0x2cd3060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cd34f0>, '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': 'af724c981e2a0f424dbabf99000001e7-1467223223.290504-140936659', '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 11:00:37 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 11:00:37 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 11:00:37 INFO - Using env: {'DISPLAY': ':0', 11:00:37 INFO - 'HOME': '/home/cltbld', 11:00:37 INFO - 'LANG': 'en_US.UTF-8', 11:00:37 INFO - 'LANGUAGE': 'en_US:en', 11:00:37 INFO - 'LOGNAME': 'cltbld', 11:00:37 INFO - 'MAIL': '/var/mail/cltbld', 11:00:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:37 INFO - 'MOZ_NO_REMOTE': '1', 11:00:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:37 INFO - 'NO_EM_RESTART': '1', 11:00:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:00:37 INFO - 'PWD': '/builds/slave/test', 11:00:37 INFO - 'SHELL': '/bin/bash', 11:00:37 INFO - 'SHLVL': '1', 11:00:37 INFO - 'TERM': 'linux', 11:00:37 INFO - 'TMOUT': '86400', 11:00:37 INFO - 'USER': 'cltbld', 11:00:37 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1467223223.290504-140936659', 11:00:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:37 INFO - '_': '/tools/buildbot/bin/python'} 11:00:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:37 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 11:00:37 INFO - Cleaning up... 11:00:37 INFO - Return code: 0 11:00:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:00:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:00:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:00:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:37 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f872711df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c43410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cd2160>, '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 0x2cd3060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cd34f0>, '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': 'af724c981e2a0f424dbabf99000001e7-1467223223.290504-140936659', '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 11:00:37 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>=0.7.1'] in /builds/slave/test/build 11:00:37 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>=0.7.1 11:00:37 INFO - Using env: {'DISPLAY': ':0', 11:00:37 INFO - 'HOME': '/home/cltbld', 11:00:37 INFO - 'LANG': 'en_US.UTF-8', 11:00:37 INFO - 'LANGUAGE': 'en_US:en', 11:00:37 INFO - 'LOGNAME': 'cltbld', 11:00:37 INFO - 'MAIL': '/var/mail/cltbld', 11:00:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:37 INFO - 'MOZ_NO_REMOTE': '1', 11:00:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:37 INFO - 'NO_EM_RESTART': '1', 11:00:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:00:37 INFO - 'PWD': '/builds/slave/test', 11:00:37 INFO - 'SHELL': '/bin/bash', 11:00:37 INFO - 'SHLVL': '1', 11:00:37 INFO - 'TERM': 'linux', 11:00:37 INFO - 'TMOUT': '86400', 11:00:37 INFO - 'USER': 'cltbld', 11:00:37 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1467223223.290504-140936659', 11:00:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:37 INFO - '_': '/tools/buildbot/bin/python'} 11:00:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:37 INFO - Downloading/unpacking psutil>=0.7.1 11:00: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 11:00: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 11:00: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 11:00: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 11:00: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 11:00: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 11:00:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:00:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:00:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:00:39 INFO - Installing collected packages: psutil 11:00:39 INFO - Running setup.py install for psutil 11:00:40 INFO - building 'psutil._psutil_linux' extension 11:00:40 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 11:00:40 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 11:00:40 INFO - building 'psutil._psutil_posix' extension 11:00:40 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 11:00:40 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 11:00:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:00:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:00:40 INFO - Successfully installed psutil 11:00:40 INFO - Cleaning up... 11:00:40 INFO - Return code: 0 11:00:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:00:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:00:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:00:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:40 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f872711df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c43410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cd2160>, '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 0x2cd3060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cd34f0>, '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': 'af724c981e2a0f424dbabf99000001e7-1467223223.290504-140936659', '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 11:00:40 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.0.0'] in /builds/slave/test/build 11:00:40 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.0.0 11:00:40 INFO - Using env: {'DISPLAY': ':0', 11:00:40 INFO - 'HOME': '/home/cltbld', 11:00:40 INFO - 'LANG': 'en_US.UTF-8', 11:00:40 INFO - 'LANGUAGE': 'en_US:en', 11:00:40 INFO - 'LOGNAME': 'cltbld', 11:00:40 INFO - 'MAIL': '/var/mail/cltbld', 11:00:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:40 INFO - 'MOZ_NO_REMOTE': '1', 11:00:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:40 INFO - 'NO_EM_RESTART': '1', 11:00:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:00:40 INFO - 'PWD': '/builds/slave/test', 11:00:40 INFO - 'SHELL': '/bin/bash', 11:00:40 INFO - 'SHLVL': '1', 11:00:40 INFO - 'TERM': 'linux', 11:00:40 INFO - 'TMOUT': '86400', 11:00:40 INFO - 'USER': 'cltbld', 11:00:40 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1467223223.290504-140936659', 11:00:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:40 INFO - '_': '/tools/buildbot/bin/python'} 11:00:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:00:40 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 11:00:40 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 11:00:40 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 11:00:40 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 11:00:40 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 11:00:40 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 11:00:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:00:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:00:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:00:42 INFO - Installing collected packages: mozsystemmonitor 11:00:42 INFO - Running setup.py install for mozsystemmonitor 11:00:42 INFO - Successfully installed mozsystemmonitor 11:00:42 INFO - Cleaning up... 11:00:42 INFO - Return code: 0 11:00:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:00:42 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')]} 11:00:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:42 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')]} 11:00:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:42 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 0x7f872711df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c43410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cd2160>, '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 0x2cd3060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cd34f0>, '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': 'af724c981e2a0f424dbabf99000001e7-1467223223.290504-140936659', '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 11:00:42 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 11:00:42 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 11:00:42 INFO - Using env: {'DISPLAY': ':0', 11:00:42 INFO - 'HOME': '/home/cltbld', 11:00:42 INFO - 'LANG': 'en_US.UTF-8', 11:00:42 INFO - 'LANGUAGE': 'en_US:en', 11:00:42 INFO - 'LOGNAME': 'cltbld', 11:00:42 INFO - 'MAIL': '/var/mail/cltbld', 11:00:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:42 INFO - 'MOZ_NO_REMOTE': '1', 11:00:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:42 INFO - 'NO_EM_RESTART': '1', 11:00:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:00:42 INFO - 'PWD': '/builds/slave/test', 11:00:42 INFO - 'SHELL': '/bin/bash', 11:00:42 INFO - 'SHLVL': '1', 11:00:42 INFO - 'TERM': 'linux', 11:00:42 INFO - 'TMOUT': '86400', 11:00:42 INFO - 'USER': 'cltbld', 11:00:42 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1467223223.290504-140936659', 11:00:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:42 INFO - '_': '/tools/buildbot/bin/python'} 11:00:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:43 INFO - Downloading/unpacking blobuploader==1.2.4 11:00:43 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 11:00:43 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 11:00:43 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 11:00:43 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 11:00:43 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 11:00:43 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 11:00:44 INFO - Downloading blobuploader-1.2.4.tar.gz 11:00:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:00:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:00:44 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 11:00:44 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 11:00:44 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 11:00:44 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 11:00:44 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 11:00:44 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 11:00:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:00:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:00:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:45 INFO - Downloading docopt-0.6.1.tar.gz 11:00:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:00:45 INFO - Installing collected packages: blobuploader, requests, docopt 11:00:45 INFO - Running setup.py install for blobuploader 11:00:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:00:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:00:45 INFO - Running setup.py install for requests 11:00:46 INFO - Running setup.py install for docopt 11:00:46 INFO - Successfully installed blobuploader requests docopt 11:00:46 INFO - Cleaning up... 11:00:46 INFO - Return code: 0 11:00:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:00:46 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')]} 11:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:46 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')]} 11:00:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:46 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 0x7f872711df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c43410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cd2160>, '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 0x2cd3060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cd34f0>, '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': 'af724c981e2a0f424dbabf99000001e7-1467223223.290504-140936659', '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 11:00:46 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 11:00:46 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 11:00:46 INFO - Using env: {'DISPLAY': ':0', 11:00:46 INFO - 'HOME': '/home/cltbld', 11:00:46 INFO - 'LANG': 'en_US.UTF-8', 11:00:46 INFO - 'LANGUAGE': 'en_US:en', 11:00:46 INFO - 'LOGNAME': 'cltbld', 11:00:46 INFO - 'MAIL': '/var/mail/cltbld', 11:00:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:46 INFO - 'MOZ_NO_REMOTE': '1', 11:00:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:46 INFO - 'NO_EM_RESTART': '1', 11:00:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:00:46 INFO - 'PWD': '/builds/slave/test', 11:00:46 INFO - 'SHELL': '/bin/bash', 11:00:46 INFO - 'SHLVL': '1', 11:00:46 INFO - 'TERM': 'linux', 11:00:46 INFO - 'TMOUT': '86400', 11:00:46 INFO - 'USER': 'cltbld', 11:00:46 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1467223223.290504-140936659', 11:00:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:46 INFO - '_': '/tools/buildbot/bin/python'} 11:00:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:00:46 INFO - Running setup.py (path:/tmp/pip-obiRnT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:00:46 INFO - Running setup.py (path:/tmp/pip-Rs9jn4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:00:46 INFO - Running setup.py (path:/tmp/pip-QS0u7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:00:46 INFO - Running setup.py (path:/tmp/pip-dn0Yr9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:00:46 INFO - Running setup.py (path:/tmp/pip-kHbO6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:00:46 INFO - Running setup.py (path:/tmp/pip-7vZ6dV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:00:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:00:46 INFO - Running setup.py (path:/tmp/pip-HptExz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:00:47 INFO - Running setup.py (path:/tmp/pip-c1Ahx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:00:47 INFO - Running setup.py (path:/tmp/pip-acGx96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:00:47 INFO - Running setup.py (path:/tmp/pip-nqYxh9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:00:47 INFO - Running setup.py (path:/tmp/pip-Pit3Zw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:00:47 INFO - Running setup.py (path:/tmp/pip-VAt5Td-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:00:47 INFO - Running setup.py (path:/tmp/pip-pzm7uS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:00:47 INFO - Running setup.py (path:/tmp/pip-yq3Kb5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:00:47 INFO - Running setup.py (path:/tmp/pip-SF3p8Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:00:47 INFO - Running setup.py (path:/tmp/pip-zZWN4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:00:47 INFO - Running setup.py (path:/tmp/pip-GHATPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:00:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:00:47 INFO - Running setup.py install for manifestparser 11:00:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:00:47 INFO - Running setup.py install for mozcrash 11:00:47 INFO - Running setup.py install for mozdebug 11:00:48 INFO - Running setup.py install for mozdevice 11:00:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:00:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:00:48 INFO - Running setup.py install for mozfile 11:00:48 INFO - Running setup.py install for mozhttpd 11:00:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:00:48 INFO - Running setup.py install for mozinfo 11:00:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:00:48 INFO - Running setup.py install for mozInstall 11:00:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:00:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:00:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:00:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:00:48 INFO - Running setup.py install for mozleak 11:00:48 INFO - Running setup.py install for mozlog 11:00:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:00:48 INFO - Running setup.py install for moznetwork 11:00:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:00:48 INFO - Running setup.py install for mozprocess 11:00:48 INFO - Running setup.py install for mozprofile 11:00:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:00:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:00:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:00:49 INFO - Running setup.py install for mozrunner 11:00:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:00:49 INFO - Running setup.py install for mozscreenshot 11:00:49 INFO - Running setup.py install for moztest 11:00:49 INFO - Running setup.py install for mozversion 11:00:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:00:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:00:49 INFO - Cleaning up... 11:00:49 INFO - Return code: 0 11:00:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:00:49 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')]} 11:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:49 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')]} 11:00:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:49 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 0x7f872711df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c43410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cd2160>, '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 0x2cd3060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cd34f0>, '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': 'af724c981e2a0f424dbabf99000001e7-1467223223.290504-140936659', '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 11:00:49 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 11:00:49 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 11:00:49 INFO - Using env: {'DISPLAY': ':0', 11:00:49 INFO - 'HOME': '/home/cltbld', 11:00:49 INFO - 'LANG': 'en_US.UTF-8', 11:00:49 INFO - 'LANGUAGE': 'en_US:en', 11:00:49 INFO - 'LOGNAME': 'cltbld', 11:00:49 INFO - 'MAIL': '/var/mail/cltbld', 11:00:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:49 INFO - 'MOZ_NO_REMOTE': '1', 11:00:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:49 INFO - 'NO_EM_RESTART': '1', 11:00:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:00:49 INFO - 'PWD': '/builds/slave/test', 11:00:49 INFO - 'SHELL': '/bin/bash', 11:00:49 INFO - 'SHLVL': '1', 11:00:49 INFO - 'TERM': 'linux', 11:00:49 INFO - 'TMOUT': '86400', 11:00:49 INFO - 'USER': 'cltbld', 11:00:49 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1467223223.290504-140936659', 11:00:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:49 INFO - '_': '/tools/buildbot/bin/python'} 11:00:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:00:49 INFO - Running setup.py (path:/tmp/pip-u_ZwVy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:00:49 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)) 11:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:00:49 INFO - Running setup.py (path:/tmp/pip-SLFLRv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:00:49 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)) 11:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:00:49 INFO - Running setup.py (path:/tmp/pip-pD64qu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:00:49 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)) 11:00:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:00:49 INFO - Running setup.py (path:/tmp/pip-ld3vSn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:00:50 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)) 11:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:00:50 INFO - Running setup.py (path:/tmp/pip-sNTpR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:00:50 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)) 11:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:00:50 INFO - Running setup.py (path:/tmp/pip-YmVTrX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:00:50 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)) 11:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:00:50 INFO - Running setup.py (path:/tmp/pip-iEI1l1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:00:50 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)) 11:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:00:50 INFO - Running setup.py (path:/tmp/pip-rKgPXe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:00:50 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)) 11:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:00:50 INFO - Running setup.py (path:/tmp/pip-56KTir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:00:50 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)) 11:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:00:50 INFO - Running setup.py (path:/tmp/pip-_03Ozt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:00:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 11:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:00:50 INFO - Running setup.py (path:/tmp/pip-brwaOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:00:50 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)) 11:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:00:50 INFO - Running setup.py (path:/tmp/pip-iagYT3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:00:50 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)) 11:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:00:50 INFO - Running setup.py (path:/tmp/pip-XLQjVe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:00:50 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)) 11:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:00:50 INFO - Running setup.py (path:/tmp/pip-mgyvPx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:00:50 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)) 11:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:00:50 INFO - Running setup.py (path:/tmp/pip-580r2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:00:50 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)) 11:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:00:50 INFO - Running setup.py (path:/tmp/pip-COF_Tf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:00:50 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)) 11:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:00:50 INFO - Running setup.py (path:/tmp/pip-8eai0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:00:50 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)) 11:00:50 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)) 11:00:50 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)) 11:00:50 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)) 11:00:50 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)) 11:00:50 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)) 11:00:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:00:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:52 INFO - Downloading blessings-1.6.tar.gz 11:00:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:00:52 INFO - Installing collected packages: blessings 11:00:52 INFO - Running setup.py install for blessings 11:00:53 INFO - Successfully installed blessings 11:00:53 INFO - Cleaning up... 11:00:53 INFO - Return code: 0 11:00:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:00:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:00:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:00:53 INFO - Reading from file tmpfile_stdout 11:00:53 INFO - Current package versions: 11:00:53 INFO - argparse == 1.2.1 11:00:53 INFO - blessings == 1.6 11:00:53 INFO - blobuploader == 1.2.4 11:00:53 INFO - docopt == 0.6.1 11:00:53 INFO - manifestparser == 1.1 11:00:53 INFO - mozInstall == 1.12 11:00:53 INFO - mozcrash == 0.17 11:00:53 INFO - mozdebug == 0.1 11:00:53 INFO - mozdevice == 0.48 11:00:53 INFO - mozfile == 1.2 11:00:53 INFO - mozhttpd == 0.7 11:00:53 INFO - mozinfo == 0.9 11:00:53 INFO - mozleak == 0.1 11:00:53 INFO - mozlog == 3.1 11:00:53 INFO - moznetwork == 0.27 11:00:53 INFO - mozprocess == 0.22 11:00:53 INFO - mozprofile == 0.28 11:00:53 INFO - mozrunner == 6.11 11:00:53 INFO - mozscreenshot == 0.1 11:00:53 INFO - mozsystemmonitor == 0.0 11:00:53 INFO - moztest == 0.7 11:00:53 INFO - mozversion == 1.4 11:00:53 INFO - psutil == 3.1.1 11:00:53 INFO - requests == 1.2.3 11:00:53 INFO - wsgiref == 0.1.2 11:00:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:00:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:00:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:53 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 0x7f872711df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c43410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cd2160>, '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 0x2cd3060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cd34f0>, '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': 'af724c981e2a0f424dbabf99000001e7-1467223223.290504-140936659', '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 11:00:53 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 11:00:53 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 11:00:53 INFO - Using env: {'DISPLAY': ':0', 11:00:53 INFO - 'HOME': '/home/cltbld', 11:00:53 INFO - 'LANG': 'en_US.UTF-8', 11:00:53 INFO - 'LANGUAGE': 'en_US:en', 11:00:53 INFO - 'LOGNAME': 'cltbld', 11:00:53 INFO - 'MAIL': '/var/mail/cltbld', 11:00:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:53 INFO - 'MOZ_NO_REMOTE': '1', 11:00:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:53 INFO - 'NO_EM_RESTART': '1', 11:00:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:00:53 INFO - 'PWD': '/builds/slave/test', 11:00:53 INFO - 'SHELL': '/bin/bash', 11:00:53 INFO - 'SHLVL': '1', 11:00:53 INFO - 'TERM': 'linux', 11:00:53 INFO - 'TMOUT': '86400', 11:00:53 INFO - 'USER': 'cltbld', 11:00:53 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1467223223.290504-140936659', 11:00:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:53 INFO - '_': '/tools/buildbot/bin/python'} 11:00:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:53 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)) 11:00:53 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)) 11:00:53 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)) 11:00:53 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)) 11:00:53 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)) 11:00:53 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)) 11:00:53 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)) 11:00:53 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)) 11:00:53 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)) 11:00:53 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)) 11:00:53 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)) 11:00:53 INFO - Cleaning up... 11:00:53 INFO - Return code: 0 11:00:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:00:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:00:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f872711df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c43410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cd2160>, '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 0x2cd3060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cd34f0>, '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': 'af724c981e2a0f424dbabf99000001e7-1467223223.290504-140936659', '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 11:00:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:00:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:00:53 INFO - Using env: {'DISPLAY': ':0', 11:00:53 INFO - 'HOME': '/home/cltbld', 11:00:53 INFO - 'LANG': 'en_US.UTF-8', 11:00:53 INFO - 'LANGUAGE': 'en_US:en', 11:00:53 INFO - 'LOGNAME': 'cltbld', 11:00:53 INFO - 'MAIL': '/var/mail/cltbld', 11:00:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:53 INFO - 'MOZ_NO_REMOTE': '1', 11:00:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:53 INFO - 'NO_EM_RESTART': '1', 11:00:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:00:53 INFO - 'PWD': '/builds/slave/test', 11:00:53 INFO - 'SHELL': '/bin/bash', 11:00:53 INFO - 'SHLVL': '1', 11:00:53 INFO - 'TERM': 'linux', 11:00:53 INFO - 'TMOUT': '86400', 11:00:53 INFO - 'USER': 'cltbld', 11:00:53 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1467223223.290504-140936659', 11:00:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:53 INFO - '_': '/tools/buildbot/bin/python'} 11:00:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:53 INFO - Downloading/unpacking jsonschema 11:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:00:55 INFO - Downloading/unpacking functools32 (from jsonschema) 11:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:56 INFO - Downloading functools32-3.2.3-2.tar.gz 11:00:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:00:56 INFO - warning: no files found matching '*.txt' 11:00:56 INFO - no previously-included directories found matching 'build' 11:00:56 INFO - no previously-included directories found matching 'dist' 11:00:56 INFO - no previously-included directories found matching '.git*' 11:00:56 INFO - Installing collected packages: jsonschema, functools32 11:00:56 INFO - Running setup.py install for functools32 11:00:56 INFO - warning: no files found matching '*.txt' 11:00:56 INFO - no previously-included directories found matching 'build' 11:00:56 INFO - no previously-included directories found matching 'dist' 11:00:56 INFO - no previously-included directories found matching '.git*' 11:00:56 INFO - Successfully installed jsonschema functools32 11:00:56 INFO - Cleaning up... 11:00:56 INFO - Return code: 0 11:00:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:00: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')]} 11:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:00:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00: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')]} 11:00:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:00:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:00:56 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 0x7f872711df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c43410>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cd2160>, '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 0x2cd3060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cd34f0>, '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': 'af724c981e2a0f424dbabf99000001e7-1467223223.290504-140936659', '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 11:00:56 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 11:00:56 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 11:00:56 INFO - Using env: {'DISPLAY': ':0', 11:00:56 INFO - 'HOME': '/home/cltbld', 11:00:56 INFO - 'LANG': 'en_US.UTF-8', 11:00:56 INFO - 'LANGUAGE': 'en_US:en', 11:00:56 INFO - 'LOGNAME': 'cltbld', 11:00:56 INFO - 'MAIL': '/var/mail/cltbld', 11:00:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:56 INFO - 'MOZ_NO_REMOTE': '1', 11:00:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:56 INFO - 'NO_EM_RESTART': '1', 11:00:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:00:56 INFO - 'PWD': '/builds/slave/test', 11:00:56 INFO - 'SHELL': '/bin/bash', 11:00:56 INFO - 'SHLVL': '1', 11:00:56 INFO - 'TERM': 'linux', 11:00:56 INFO - 'TMOUT': '86400', 11:00:56 INFO - 'USER': 'cltbld', 11:00:56 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1467223223.290504-140936659', 11:00:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:56 INFO - '_': '/tools/buildbot/bin/python'} 11:00:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:00:56 INFO - Downloading/unpacking flake8 11:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:00:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:00:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:00:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:00:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:00:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:00:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:00:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:00:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:00:59 INFO - no previously-included directories found matching 'docs/_build' 11:00:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:00:59 INFO - Running setup.py install for pep8 11:00:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:00:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:00:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:00:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:00:59 INFO - no previously-included directories found matching 'docs/_build' 11:00:59 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:00:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:00:59 INFO - Cleaning up... 11:00:59 INFO - Return code: 0 11:00:59 INFO - Running post-action listener: _resource_record_post_action 11:00:59 INFO - Running post-action listener: _start_resource_monitoring 11:00:59 INFO - Starting resource monitoring. 11:00:59 INFO - ##### 11:00:59 INFO - ##### Running install step. 11:00:59 INFO - ##### 11:00:59 INFO - Running pre-action listener: _resource_record_pre_action 11:00:59 INFO - Running main action method: install 11:00:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:00:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:00:59 INFO - Reading from file tmpfile_stdout 11:00:59 INFO - Detecting whether we're running mozinstall >=1.0... 11:00:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:00:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:00:59 INFO - Reading from file tmpfile_stdout 11:00:59 INFO - Output received: 11:00:59 INFO - Usage: mozinstall [options] installer 11:00:59 INFO - Options: 11:00:59 INFO - -h, --help show this help message and exit 11:00:59 INFO - -d DEST, --destination=DEST 11:00:59 INFO - Directory to install application into. [default: 11:00:59 INFO - "/builds/slave/test"] 11:00:59 INFO - --app=APP Application being installed. [default: firefox] 11:00:59 INFO - mkdir: /builds/slave/test/build/application 11:00:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:00:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:01:14 INFO - Reading from file tmpfile_stdout 11:01:14 INFO - Output received: 11:01:14 INFO - /builds/slave/test/build/application/firefox/firefox 11:01:14 INFO - Running post-action listener: _resource_record_post_action 11:01:14 INFO - ##### 11:01:14 INFO - ##### Running run-tests step. 11:01:14 INFO - ##### 11:01:14 INFO - Running pre-action listener: _resource_record_pre_action 11:01:14 INFO - Running main action method: run_tests 11:01:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:01:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:01:14 INFO - Python 2.7.3 11:01:14 INFO - Return code: 0 11:01:14 INFO - grabbing minidump binary from tooltool 11:01:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:01:14 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cd2160>, '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 0x2cd3060>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cd34f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:01:14 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 11:01:14 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 11:01:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:01:14 INFO - Return code: 0 11:01:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:01:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:01:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:01:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:01:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:01:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:01:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:01:15 INFO - Return code: 0 11:01:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 11:01:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Larch-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 11:01:15 INFO - Using env: {'DISPLAY': ':0', 11:01:15 INFO - 'HOME': '/home/cltbld', 11:01:15 INFO - 'LANG': 'en_US.UTF-8', 11:01:15 INFO - 'LANGUAGE': 'en_US:en', 11:01:15 INFO - 'LOGNAME': 'cltbld', 11:01:15 INFO - 'MAIL': '/var/mail/cltbld', 11:01:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:01:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:01:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:01:15 INFO - 'MOZ_NO_REMOTE': '1', 11:01:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:01:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:01:15 INFO - 'NO_EM_RESTART': '1', 11:01:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:01:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:01:15 INFO - 'PWD': '/builds/slave/test', 11:01:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:01:15 INFO - 'SHELL': '/bin/bash', 11:01:15 INFO - 'SHLVL': '1', 11:01:15 INFO - 'TERM': 'linux', 11:01:15 INFO - 'TMOUT': '86400', 11:01:15 INFO - 'USER': 'cltbld', 11:01:15 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1467223223.290504-140936659', 11:01:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:01:15 INFO - '_': '/tools/buildbot/bin/python'} 11:01:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 11:01:15 INFO - mozversion application_buildid: 20160629092027 11:01:15 INFO - mozversion application_changeset: 053b0f43de1f6c52af2ab2187e4d0a11f453a7d4 11:01:15 INFO - mozversion application_display_name: Nightly 11:01:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:01:15 INFO - mozversion application_name: Firefox 11:01:15 INFO - mozversion application_remotingname: firefox 11:01:15 INFO - mozversion application_repository: https://hg.mozilla.org/projects/larch 11:01:15 INFO - mozversion application_vendor: Mozilla 11:01:15 INFO - mozversion application_version: 47.0.2 11:01:15 INFO - mozversion platform_buildid: 20160629092027 11:01:15 INFO - mozversion platform_changeset: 053b0f43de1f6c52af2ab2187e4d0a11f453a7d4 11:01:15 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/larch 11:01:15 INFO - mozversion platform_version: 47.0.2 11:01:15 INFO - using testdate: 1467223275 11:01:15 INFO - actual date: 1467223275 11:01:15 INFO - starting webserver on 'localhost:35291' 11:01:15 INFO - SUITE-START | Running 2 tests 11:01:15 INFO - TEST-START | dromaeo_css 11:01:15 INFO - operating with platform_type : linux_ 11:01:15 INFO - Initialising browser for dromaeo_css test... 11:01:15 INFO - TEST-INFO | started process 24073 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfv5_QP/profile http://localhost:35291/getInfo.html) 11:01:21 INFO - PROCESS | 24073 | __metrics Screen width/height:1600/1200 11:01:21 INFO - PROCESS | 24073 | colorDepth:24 11:01:21 INFO - PROCESS | 24073 | Browser inner width/height: 1024/697 11:01:21 INFO - PROCESS | 24073 | __metrics 11:01:21 INFO - PROCESS | 24073 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:01:22 INFO - TEST-INFO | 24073: exit 0 11:01:22 INFO - Browser initialized. 11:01:22 INFO - Running cycle 1/1 for dromaeo_css test... 11:01:22 INFO - TEST-INFO | started process 24165 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfv5_QP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:01:34 INFO - PROCESS | 24165 | RSS: Main: 138993664 11:01:34 INFO - PROCESS | 24165 | 11:02:25 INFO - PROCESS | 24165 | 1467223345572 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] 11:04:37 INFO - PROCESS | 24165 | Cycle 1(1): loaded http://localhost:35291/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35291/tests/dromaeo/cssquery-ext.html) 11:04:38 INFO - PROCESS | 24165 | RSS: Main: 218693632 11:04:38 INFO - PROCESS | 24165 | 11:07:40 INFO - PROCESS | 24165 | Cycle 1(1): loaded http://localhost:35291/tests/dromaeo/cssquery-ext.html (next: http://localhost:35291/tests/dromaeo/cssquery-jquery.html) 11:07:40 INFO - PROCESS | 24165 | RSS: Main: 218513408 11:07:40 INFO - PROCESS | 24165 | 11:10:42 INFO - PROCESS | 24165 | Cycle 1(1): loaded http://localhost:35291/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35291/tests/dromaeo/cssquery-mootools.html) 11:10:43 INFO - PROCESS | 24165 | RSS: Main: 213647360 11:10:43 INFO - PROCESS | 24165 | 11:13:44 INFO - PROCESS | 24165 | Cycle 1(1): loaded http://localhost:35291/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35291/tests/dromaeo/cssquery-prototype.html) 11:13:45 INFO - PROCESS | 24165 | RSS: Main: 193318912 11:13:45 INFO - PROCESS | 24165 | 11:16:48 INFO - PROCESS | 24165 | Cycle 1(1): loaded http://localhost:35291/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35291/tests/dromaeo/cssquery-yui.html) 11:16:48 INFO - PROCESS | 24165 | RSS: Main: 189005824 11:16:48 INFO - PROCESS | 24165 | 11:19:50 INFO - PROCESS | 24165 | Cycle 1(1): loaded http://localhost:35291/tests/dromaeo/cssquery-yui.html (next: http://localhost:35291/tests/dromaeo/cssquery-dojo.html) 11:19:51 INFO - PROCESS | 24165 | RSS: Main: 245317632 11:19:51 INFO - PROCESS | 24165 | 11:19:51 INFO - PROCESS | 24165 | __start_tp_report 11:19:51 INFO - PROCESS | 24165 | _x_x_mozilla_page_load 11:19:51 INFO - PROCESS | 24165 | _x_x_mozilla_page_load_details 11:19:51 INFO - PROCESS | 24165 | |i|pagename|runs| 11:19:51 INFO - PROCESS | 24165 | |0;dojo.html;2778.9861050694744;2855.4289142171556;2868.8135271207357;2888;2896.449674561833;4702.0360826030665;4732.10090082884;4739.715617062979;4749.913986965908;4768.070226305867;4730.929036064454;4737.526247375269;4758.238681810911;4760.547747963947;4791.353167322411;4103.281925663012;4270.743755374672;4349.0432104936945;4363.803628836694;4406.250937340644;4278.893027674318;4285.807138678767;4360.672949528782;4419.558044195571;4467.642588592921;4325.870223893288;4421.137878113769;4421.9336709949375;4441.689081764278;4464.776761161945;4357.520672725997;4375.58431948966;4408.206522825906;4411.250087485103;4423.336499525065;4183.748975061506;4237.682173836944;4321.049369138785;4337.262665346867;4345.826166953318;4553.4991150973365;4557.703749256288;4573.885652858672;4578.748168850712;4586.128635559233;4928.088303663798;4935.210366341368;4938.061768264054;4946.1344264753525;4958.925616115761;4859.538343857328;5041.747912604392;5088.389393272794;5117.360329958755;5134.281200631877;4585.839495617637;4603.792829322689;4611.677182597253;4621.21439355307;4645.256758918556;4986.90026199474;5032.974835125874;5060.468650791614;5062.7468626568525;5064.620153488503;4910.386201724785;4953.8513844583995;4991.301217829507;4995.250712393097;4995.675281106789;5019.372578427697;5026.89946201074;5030.119729047402;5032.949670503322;5066.088104141216;4788.353572267769;4953.43035550909;4976.4525902150735;4990.4011518618;5018.372703412074;4833.927491087637;4902.41171059468;4962.7022378656675;4969.577585905166;5012.874678133003;4242;4260.339647354665;4263.275243208662;4284.207421627009;4290.935635965463;3638.690711289517;3753.6246375362794;3793.506844110248;3795.013296542919;3821.2548553031893;4422.800973956179;4425.734455932655;4428.579284967923;4443.622292105143;4454.554544545585;5006.849794506171;5025.949740502621;5029.622778291643;5030.144875371196;5045.310308468235;4276.615104640598;4389.166058448948;4412.933805992912;4443.777811109496;4459.175052615276;4516.051629157913;4542.545745425497;4550.863474095782;4553.4991150973365;4565.497795242521;4855.223164293696;4857.587105096036;4862.41651001882;4879.316895634685;4908.092002979461;4916.287138364989;5000.649954503296;5058.190689489811;5080.847574572768;5081.974590127025;4845.709257444564;4846.660733748745;4854.538818812349;4869.245266983623;4900.019996000886;4962.950370496249;4963.528464795839;4975.6019518437715;4990.525900039491;5012.097822392005;4810.182269014206;5047.192449208109;5095.923561146512;5113.463086376026;5116.411612664591;4839.177339852163;4890.144224760724;4892.510748925079;4899.265110233494;4920.581750551243;4729.858104256878;4864.270359446112;4897.461279259207;4902.779374928208;4920.6801557898625;4686.156491831503;4744.074905393415;4783.832565860178;4807.687500312469;4819.493953135011;4888.071266459504;4966.900661986812;4967.950320496749;4968.527989840959;4991.5008499151245;4818.349522814376;4834.8791280218275;4846.806127754991;4856.344393506973;4882.853514394574 11:19:51 INFO - PROCESS | 24165 | |1;ext.html;508.8422588997411;518.6887867279631;519.7557148140378;526.5050852198933;551.3659291814414;27554.86222568887;34630.480542791876;35195.296094078134;35251.82374088132;35292;37418.4387234191;37922;37948;37949.81025094871;37986.24027519448;7816.491928024674;8030.397720170981;8030.9196908031045;8032.799180020517;8034.5982700865015;7909.525428474281;8038.954935858359;8046.114927358015;8052.315553177987;8054.718084867001;8019.799505012392;8265.545395003272;8308.916910830874;8317.29303009242;8323.750287491355;8189.385796065319;8266.751997440026;8273.089960104413;8275.586220688941;8275.917240827575;8159.592020399015;8296.253337199621;8296.419250652456;8297.377696672773;8314.62584183707;38142;38485.80757096224;38511.03722406934;38596.61403385958;38717.80641096805;2654.3762215879447;2693.3266683329166;2746.1898739871785;2869.899553515617;3006.8045577037424;28696;29230;29274.121776346532;29289.70710292891;29359.70640293591;3112.7821052526333;3116.4234616596004;3142.685731426862;3176.174194709369;3227.9677203227902;230975;231286;231768;232004;232097.83951080305;54150.18774718382;54184;54461;54749;54768.45231547713;62187;63787;63796.68101659462;63813.36186638074;63916.68041659855;11292.37891915936;11351.091912646969;11422.200445968703;11461.770764584828;11469.082473402108;8755.168259015383;8781.91218087811;8791.340649451316;8812.559372031374;8818.29453643707;19359.51601209981;19738.40784776459;19795.901020495094;20396.592068158552;20583.279585214445;7069.363757261871;7167.89248161278;7227.89158162628;7268.454865884974;7329.633518324063;904.1681652879366;917.4311926605413;934.4299977014152;986.0041358228098;1028.7222449938474;26999.865000675265;27146;27295.86352068227;27695.169144925683;27767.722322776917;918.6141820435299;1015.7816069544936;1035.9847349597437;1062.2776511971779;1089.4226060188114;12137.501061581668;12559.246445213317;12662.113652044269;12666;12699.746005079847;285243;288576;288648;289174;289655;47875;48168.518314817105;48409;48409.515904840504;48524;1150.9942450287695;1203.8194270859442;1248.3945286536023;1252.2861968677948;1287.7617640736494;23955.520889581763;24879.875600621883;26785;27015.59476607813;27031.72968270292;38022.61977380191;38270.42594361031;38308.23383532258;38353.80823095867;38383;189980;190950;191099;191498;191831;31289.8435507821;31518;31777.364452711277;31898.84050579732;32068.35863282768;40949.795251023555;41117.58882411257;41540.79229603833;42151;42320.788396057826;34389.484157737155;34566.65433345635;34575;34646;34698;34470.65529344775;34964.30071398507;35139.29721405506;35247.82376088103;35457;32200.35599288048;32417.513737293488;33256.50115248225;36095;36444;31796.04611861648;32720.83639581882;32846.34307313793;33205.169870752456;33293.33413331671;25552.361190970376;25605.231843044738;26354.86822565875;26367.675645654017;28355.82615248839 11:19:51 INFO - PROCESS | 24165 | |2;jquery.html;347.95302634144383;358.4748343676514;359.3495772651501;362.619249787723;363.14298256115546;15611.687766244668;16004.201722309763;16327.591810204736;16788.83211167888;16829.579260518494;12712.872871271284;14009.439622415091;14421.711565768705;14538.927305363484;14540;5023.29673845661;5097.949020509803;5153.098207813637;5159.174532074869;5184.196449550326;5015.623828212881;5031.748412579374;5135.58915286778;5182.922256166161;5195.506426889458;5137.229415587673;5137.691738495683;5138.537531622153;5140.588752899777;5147.716875571842;5123.308353372285;5173.3533308336455;5392.110301800199;5403.540699040566;5406.378266499363;5149.665271757323;5173.793048278064;5181.611379146579;5189.065968125736;5193.428722840485;12889.548865789746;19167.424977250706;19963;20047.198112075646;20052.899735501374;1780.5993651428455;1787.195761907134;1788.9016104114269;1851.1022154255174;1856.4894653970132;9491.715248542554;9501.097395747393;9534.856977145348;9605.423674579548;11763.35301558414;1717.9570510737205;1724.8188940161353;1826.2147276671026;1863.1150203653156;1898.0880356027726;34866;45515.54484455146;50229.18697358256;56548.71725641387;57113;9268.119528644902;9407.670731524364;9494.477803720862;9596.040395960348;9597.952010239904;11859.644210673694;13014.21914685122;13041.347932603521;13063.216207027419;13095;6146.293176284695;6333.588316759396;6403.071554624554;6408.10286559882;6466.159399278064;6000.559865632217;6026.668533230714;6080.027195648763;6085.026395776655;6106.053561697855;4091.91816163681;4093.16090201508;4111.691623128278;4122.2579935611875;4178.561251068655;1732.237815361237;1743.389813565242;1752.1502071495315;1770.1237887245895;1788.3740690758132;802.7792357101844;805.1867613710195;835.5488036460243;869.5826003518221;940.4874343482818;15220;15599.844001559839;15844.53961883657;16319.83680163183;16442.83557164437;856.3834039491556;867.8871746672892;884.7345796261096;899.8335307968047;967.8161149381594;9065.138811812867;9110.81778364429;9280.814383712288;9390.953045234866;9454.716358509255;365502;367310;369472;378743;387082;66973;68034.65982670055;68244.3175568238;68818;69569.65215173892;831.5592735850009;882.3602887906345;892.906244844295;917.0691747875911;918.6141820435433;14140.43438262458;14420.134791912518;15360;15409.537713868602;15511.301991410639;32538.674613253563;32791.34417311688;33328.66671333255;33387.1653208662;33651.66348336583;41334;41383.586164137974;41648.375274371516;41718.374224386054;42875.5712442884;7550.320471157403;7561.810954726176;7637.5799331035105;7662.157162711986;7700.19147989453;8655.826883462421;10754.300970436896;11500.367479788692;11617.128715346214;11646.534138634359;9322.906770932204;10036.949815250877;10200.744981375525;10229.386236825814;10404.739881503023;9986.800263994824;9996.700098997042;10106.292559520763;10139.087482126644;10193.727626226715;9697.806043879224;10325.9483702581;10350.223733219887;10420.895791041992;10429.63496277657;7590.620468976639;7648.34989025939;7766.262205090507;7833.529988200727;7987.800304992422;9516.952415238156;10071;10174.23693223026;10246.180305575685;10314.484275786332 11:19:51 INFO - PROCESS | 24165 | |3;mootools.html;1200.1299058182813;1322.1538215542053;1333.1601091312473;1396.8323801143865;1715.3996101364517;7511.661975211115;7704.730334438295;7727.574983375919;7747.341475974535;7763.611819409028;7642.197569255231;7774.105977812554;7839.843203135933;7842.960785196066;7843.607819609011;2178.335607639673;2217.8558393704357;2223.188536184289;2226.8441209115285;2239.2274665240466;2220.7779222077743;2226.0984301357976;2273.4089136824377;2282.2126366403645;2286.6455699366543;2065.070718176819;2073.4712648274667;2075.9584808303825;2128.095559387262;2208.447888027993;2237.697910782048;2237.9888100559556;2250.189931624614;2252.4594097416666;2263.128695452246;2257.932262032142;2262.7963483286417;2266.172846910882;2281.7946384825277;2282.6119559674894;7908.169642187545;7944.642491087915;7955.4033447491665;7957.2042795720545;7965.163657815961;4390.736555806662;4507.166174257773;4512.278035514335;4518.1415531049;4527.366168736379;2776.7917406194615;2808.620836187109;2814.704456032108;2815.0569559197693;2828.702986186441;876.1676407412983;884.2704768565959;890.1365675294953;904.1817155474306;941.3269512298739;10946.671599851938;10947;10948.945255273753;10956.616518421897;11003.394813285266;4102.138550904284;4166.58334166587;4243.130158317537;4253.744775313491;4257.978710106491;9182.540872956326;9254.907450925539;9256.90743092574;9278.350515463853;9278.396904201205;4419.337099435111;4430.047539778963;4451.7996690148375;4458.509563947963;4465.888352791206;3493.3711931852004;3920.0591857953887;4031.838726450968;4032.334664780278;4039.5758445363404;3573.6426357364576;3614.7831130132276;3621.9858439636946;3659.1949771050326;3659.396199627085;1156.1213477756964;1161.7676464707092;1165.5221359242669;1169.7601991591703;1178.7878181927335;1158.7982832618093;1161.79668558002;1167.6146871532374;1179.2688533109356;1181.509673485494;7485.363744081814;7496.325330720261;7548.245175482408;7556.206598307209;7603.239676032463;453;454.4773510462994;456.82183948260206;457.2158747747629;474.71042663974947;5275.419703832576;5302.1781623848365;5309.734513274321;5337.386200586904;5369.677819330853;9412.482313472688;9677.70966870995;9948.303618746619;9985.251106167067;10034.949825250973;9705.9029409705;9827.606895724233;9847.458389788488;9862.802743945082;9886.406815591088;7154.177269614061;7254.455915806336;7315.780526584104;7321.926780732125;7332.0834895638045;7188.640567971476;7196.820079498055;7201;7246.239144889711;7252.129744430702;8663.263622591898;8677.349198810241;8915.687950921687;8933.28533717314;8938.731838044869;8835.911640883765;8942.105789421006;8965.686200982935;9114.453132812052;9118.361714679908;5582.162675598693;6340.587861788969;6474.4820414365795;6662.267150613332;6761.763338283136;7242.493025488166;7244.275572442713;7265.854682906418;7274.709011639687;7276.345128938421;6374.107624932421;6411.743530258737;6478.060681201294;6496.220453545605;6532.216134063943;6165.506759459322;6516.967415162894;6526.706298216686;6570.704318305592;6627.304133065959;6862.176538815374;6865.347791959756;6909.827254318682;6922.688479018356;6929.133858267716;6204.410580994799;6254.343293954069;6291.339409362135;6465.288818230085;6487.675616219076;6617.933820661732;6631.972044333136;6646.700898459678;6647.9002814958785;6691.698873550605 11:19:51 INFO - PROCESS | 24165 | |4;prototype.html;329.5748484455053;331.0614408152886;334.7088033410933;336.15960099750623;344.419652884889;5394.352677678679;5417.458254174586;5421.701806400646;5442.455754424555;5515.641483303582;5401.378841433237;5401.972990135054;5403.5136837684695;5405.135178371462;5415.187721841726;4081.510218773751;4159.854405095823;4232.76719780412;4261.126469073833;4276.080642661819;4254.574542545752;4284.164587905359;4304.375865499516;4312.935305970397;4316.870493885189;4227.85202517912;4268.210381079494;4272.209641216369;4273.273543497613;4274.273373526508;4038.3336749436307;4167.312393455076;4262.1049579588325;4267.722598031118;4272.124214536044;3780.981095094507;3783.375743002401;3788.78758797185;3791.0332865119217;3795.6394142556414;5209.583233341324;5215.217717342391;5219.478052194788;5220.086484865134;5221.477852214748;4911.386076740408;4916.287138364953;4918.926216106761;4919.72941488218;4924.064427758714;5702.971485142589;5707.71461426927;5709.115087161496;5710.457506536873;5727.914081288784;3866.420036994445;4135.110951145488;4157.230912281208;4161.646260067898;4161.709869940328;5934.910976335358;5980.1328807323125;6002.129691194796;6021.3677563856045;6025.216721826135;4129.855455059119;4133.173365326947;4135.214309281287;4135.669146468275;4142.46148000758;4174.039970806732;4181.623653871166;4192.580741925783;4194.643455306272;4200.348945913388;4774.928376074292;4799.9760001199775;4802.27965805125;4802.615790736802;4803.879903002383;5719.799807006735;5726.942730572724;5732.6847023413275;5734.512566431817;5740.339860915965;1414.5332040426636;1460.978085328721;1482.9629259268604;1488.1517535004944;1495.3943652820626;927.5130556457779;954.3271993244746;993.3642468819961;1004.5429329655135;1010.540204207084;5095.8980820383385;5102;5118.155504341742;5129.563987061067;5132.28148059272;5871.295444546682;5934.080217566284;5952.761889524457;5957.076653118774;5958.225430693982;5083.593312534988;5085.110105731556;5097.133487307166;5100.591952643779;5105.106606343949;3114.5483904834127;3178.6026746656667;3183.8248896310924;3185.8566364513654;3186.490161574137;5657.066584013674;5657.547396208376;5673.31920169574;5676.77292908279;5679.119736440858;5988.3113441953865;6037.305709843425;6037.72830222641;6038.973374526341;6051.8487037823525;5629.099344104923;5654.547636189095;5664.461876121762;5666.518345940559;5673.517750991212;5813.883722325614;5854.092615644582;5866.794662186803;5877.735501902339;5880.117982302689;5741.770329186786;5745.454181852718;5746.770129194785;5755.1942728017275;5761.337446193741;5537.086380747131;5628.268325117709;5648;5659;5672.7730890763905;4027.8187481562813;4049.757014579017;4078.877633670995;4084.346504559256;4112.670986321147;5979.701014949148;5988.341282458839;5989.64062156272;5996.220491336273;5999.730012149376;5755.683437410982;5756.1941328214925;5765.971170144123;5767.68277744728;5770.307563092456;5730.570207234391;5752.993226185485;5765;5769.336526299529;5774.133879918046;5477.835664930059;5639.830805075854;5644.322681278273;5647.915281270702;5670.206171135962;5803.8549036274435;5826.592138550261;5831.562632802472;5832.533397328289;5834.474897259267;5631.63394379364;5635.718214089197;5636.070048441961;5651.491365777099;5652.519535839335 11:19:51 INFO - PROCESS | 24165 | |5;yui.html;551.7489542258272;574.7729646789518;630.1618846933579;630.4483576870238;639.2201514152732;11048.447577621117;12267.815982760265;12475.251484910912;12486.81269780954;12498.437570309336;11969.401529923512;12036.157468977175;12042.69893252667;12069.577564785235;12086.939565302184;691.6507163882233;829.4194064155085;836.9958150209255;853.189470003496;853.8078932240259;779.9220077992184;784.051297929506;785.3246208260891;787.6140691061368;788.0189164490217;864.6714248585529;867.6919693508809;869.7825543614097;870.5864714260707;870.9129087091272;724.2395484741028;854.2354592639584;855.1875718067861;861.5993562993176;878.3982971664367;647.1069923505532;655.806537071565;655.9245686746037;656.238763034882;656.4420242793635;11083.944580277048;11117.777644447066;11199.384033878134;11220;11241.775164496665;11593.478293476814;12033.819492707617;12246.877531224663;12266.81599776004;12285.754284914341;9545.522723863849;9750.90249097507;9773.07155820196;9785.902140978642;9923.057309555581;3324.2188085799817;3327.866885324584;3370.2416956184907;3373.1904342957514;3398.728101751854;41436.378454322905;43232.78383608093;43694;43896.56103438957;43929.12141757147;9481.383710058824;9564.66523671682;9591.376560523684;9605.615775369046;9689.757756056155;15607.843921560867;15608.921955390151;15628.453004145027;15681.05913645185;15682.451114210948;6117.938820611826;6223.657698826608;6557.672116394161;6659.700313485808;6764.695588698521;3515.5605549306338;3578.3380074686265;3583.104223944014;3589.0847833802213;3607.8376473058775;2777.9444411111663;2816.084772448962;2818.506761316761;2819.210621026116;2825.57616357548;497.36585853036945;521.705236541353;523.8926020165857;528.4556906386429;529.6821906855855;431.8790738593199;443.66946624764114;500.82971789591716;502.79636747117473;518.082993102207;6709;6774.119364482585;6802.387785099266;6895.138107736533;6936.722531098801;420.3904338708823;448.70385545539784;507.8699892738701;520.8906129712802;521.804323378733;3221.7100460958627;3230.466972949437;3238.9838050809594;3337.9666203338143;3344.1138098403944;48773.75613121912;49509.257361139615;52285.7385713069;52773;53555.73222133942;42084.15831683349;42713.78643106827;42719.78640106842;43004.13991720148;43355;42973.78513107477;43113.13773724508;43333.566664333586;43710.344344834855;43985.56014439878;7824.334931530656;7826.843463130592;7888.171741967011;8142.18578142181;8158.224968627971;32178.517322239717;32565.674343256265;33183.33633327272;33820;34723.479147813305;42036.57963420449;42528.57471425246;42830.14339713126;43106.353404698326;43111;10404.73988150272;10428.217883658908;10506.369617822955;10579.206559508222;10644;10707.946460267649;11517.136214783757;11565.537378504765;11623.302601843916;11763.823542646696;9088.182063614306;10167.847482287623;10201.846972295272;10713.089387402159;10876.945615271872;9022.90977090247;9279;9506.334556580972;9637.614495420105;9850.113489785954;9065.773355665897;9359.110884465965;9361.953190234006;9700.75748106303;10801.729956751144;9099.909000909905;9266.9536652319;9297.535123243946;9299.72100836976;9474.810503790024;8531.829363412573;8579.914200857911;8623.180797824196;8723.040465548658;8891.110888911317 11:19:51 INFO - PROCESS | 24165 | __end_tp_report 11:19:51 INFO - PROCESS | 24165 | __start_cc_report 11:19:51 INFO - PROCESS | 24165 | _x_x_mozilla_cycle_collect,770 11:19:51 INFO - PROCESS | 24165 | __end_cc_report 11:19:51 INFO - PROCESS | 24165 | __startTimestamp1467224391212__endTimestamp 11:19:51 INFO - PROCESS | 24165 | 11:19:51 INFO - PROCESS | 24165 | ------- Summary: start ------- 11:19:51 INFO - PROCESS | 24165 | Number of tests: 6 11:19:51 INFO - PROCESS | 24165 | 11:19:51 INFO - PROCESS | 24165 | [#0] dojo.html Cycles:165 Average:4659.00 Median:4818.35 stddev:446.76 (9.3%) stddev-sans-first:423.09 11:19:51 INFO - PROCESS | 24165 | Values: 2779.0 2855.4 2868.8 2888.0 2896.4 4702.0 4732.1 4739.7 4749.9 4768.1 4730.9 4737.5 4758.2 4760.5 4791.4 4103.3 4270.7 4349.0 4363.8 4406.3 4278.9 4285.8 4360.7 4419.6 4467.6 4325.9 4421.1 4421.9 4441.7 4464.8 4357.5 4375.6 4408.2 4411.3 4423.3 4183.7 4237.7 4321.0 4337.3 4345.8 4553.5 4557.7 4573.9 4578.7 4586.1 4928.1 4935.2 4938.1 4946.1 4958.9 4859.5 5041.7 5088.4 5117.4 5134.3 4585.8 4603.8 4611.7 4621.2 4645.3 4986.9 5033.0 5060.5 5062.7 5064.6 4910.4 4953.9 4991.3 4995.3 4995.7 5019.4 5026.9 5030.1 5032.9 5066.1 4788.4 4953.4 4976.5 4990.4 5018.4 4833.9 4902.4 4962.7 4969.6 5012.9 4242.0 4260.3 4263.3 4284.2 4290.9 3638.7 3753.6 3793.5 3795.0 3821.3 4422.8 4425.7 4428.6 4443.6 4454.6 5006.8 5025.9 5029.6 5030.1 5045.3 4276.6 4389.2 4412.9 4443.8 4459.2 4516.1 4542.5 4550.9 4553.5 4565.5 4855.2 4857.6 4862.4 4879.3 4908.1 4916.3 5000.6 5058.2 5080.8 5082.0 4845.7 4846.7 4854.5 4869.2 4900.0 4963.0 4963.5 4975.6 4990.5 5012.1 4810.2 5047.2 5095.9 5113.5 5116.4 4839.2 4890.1 4892.5 4899.3 4920.6 4729.9 4864.3 4897.5 4902.8 4920.7 4686.2 4744.1 4783.8 4807.7 4819.5 4888.1 4966.9 4968.0 4968.5 4991.5 4818.3 4834.9 4846.8 4856.3 4882.9 11:19:51 INFO - PROCESS | 24165 | 11:19:51 INFO - PROCESS | 24165 | [#1] ext.html Cycles:180 Average:40403.31 Median:34831.15 stddev:62731.19 (180.1%) stddev-sans-first:62835.65 11:19:51 INFO - PROCESS | 24165 | Values: 508.8 518.7 519.8 526.5 551.4 27554.9 34630.5 35195.3 35251.8 35292.0 37418.4 37922.0 37948.0 37949.8 37986.2 7816.5 8030.4 8030.9 8032.8 8034.6 7909.5 8039.0 8046.1 8052.3 8054.7 8019.8 8265.5 8308.9 8317.3 8323.8 8189.4 8266.8 8273.1 8275.6 8275.9 8159.6 8296.3 8296.4 8297.4 8314.6 38142.0 38485.8 38511.0 38596.6 38717.8 2654.4 2693.3 2746.2 2869.9 3006.8 28696.0 29230.0 29274.1 29289.7 29359.7 3112.8 3116.4 3142.7 3176.2 3228.0 230975.0 231286.0 231768.0 232004.0 232097.8 54150.2 54184.0 54461.0 54749.0 54768.5 62187.0 63787.0 63796.7 63813.4 63916.7 11292.4 11351.1 11422.2 11461.8 11469.1 8755.2 8781.9 8791.3 8812.6 8818.3 19359.5 19738.4 19795.9 20396.6 20583.3 7069.4 7167.9 7227.9 7268.5 7329.6 904.2 917.4 934.4 986.0 1028.7 26999.9 27146.0 27295.9 27695.2 27767.7 918.6 1015.8 1036.0 1062.3 1089.4 12137.5 12559.2 12662.1 12666.0 12699.7 285243.0 288576.0 288648.0 289174.0 289655.0 47875.0 48168.5 48409.0 48409.5 48524.0 1151.0 1203.8 1248.4 1252.3 1287.8 23955.5 24879.9 26785.0 27015.6 27031.7 38022.6 38270.4 38308.2 38353.8 38383.0 189980.0 190950.0 191099.0 191498.0 191831.0 31289.8 31518.0 31777.4 31898.8 32068.4 40949.8 41117.6 41540.8 42151.0 42320.8 34389.5 34566.7 34575.0 34646.0 34698.0 34470.7 34964.3 35139.3 35247.8 35457.0 32200.4 32417.5 33256.5 36095.0 36444.0 31796.0 32720.8 32846.3 33205.2 33293.3 25552.4 25605.2 26354.9 26367.7 28355.8 11:19:51 INFO - PROCESS | 24165 | 11:19:51 INFO - PROCESS | 24165 | [#2] jquery.html Cycles:180 Average:22341.84 Median:44195.56 stddev:61242.47 (138.6%) stddev-sans-first:61392.00 11:19:51 INFO - PROCESS | 24165 | Values: 348.0 358.5 359.3 362.6 363.1 15611.7 16004.2 16327.6 16788.8 16829.6 12712.9 14009.4 14421.7 14538.9 14540.0 5023.3 5097.9 5153.1 5159.2 5184.2 5015.6 5031.7 5135.6 5182.9 5195.5 5137.2 5137.7 5138.5 5140.6 5147.7 5123.3 5173.4 5392.1 5403.5 5406.4 5149.7 5173.8 5181.6 5189.1 5193.4 12889.5 19167.4 19963.0 20047.2 20052.9 1780.6 1787.2 1788.9 1851.1 1856.5 9491.7 9501.1 9534.9 9605.4 11763.4 1718.0 1724.8 1826.2 1863.1 1898.1 34866.0 45515.5 50229.2 56548.7 57113.0 9268.1 9407.7 9494.5 9596.0 9598.0 11859.6 13014.2 13041.3 13063.2 13095.0 6146.3 6333.6 6403.1 6408.1 6466.2 6000.6 6026.7 6080.0 6085.0 6106.1 4091.9 4093.2 4111.7 4122.3 4178.6 1732.2 1743.4 1752.2 1770.1 1788.4 802.8 805.2 835.5 869.6 940.5 15220.0 15599.8 15844.5 16319.8 16442.8 856.4 867.9 884.7 899.8 967.8 9065.1 9110.8 9280.8 9391.0 9454.7 365502.0 367310.0 369472.0 378743.0 387082.0 66973.0 68034.7 68244.3 68818.0 69569.7 831.6 882.4 892.9 917.1 918.6 14140.4 14420.1 15360.0 15409.5 15511.3 32538.7 32791.3 33328.7 33387.2 33651.7 41334.0 41383.6 41648.4 41718.4 42875.6 7550.3 7561.8 7637.6 7662.2 7700.2 8655.8 10754.3 11500.4 11617.1 11646.5 9322.9 10036.9 10200.7 10229.4 10404.7 9986.8 9996.7 10106.3 10139.1 10193.7 9697.8 10325.9 10350.2 10420.9 10429.6 7590.6 7648.3 7766.3 7833.5 7987.8 9517.0 10071.0 10174.2 10246.2 10314.5 11:19:51 INFO - PROCESS | 24165 | 11:19:51 INFO - PROCESS | 24165 | [#3] mootools.html Cycles:180 Average:5404.61 Median:6315.96 stddev:2954.19 (46.8%) stddev-sans-first:2945.58 11:19:51 INFO - PROCESS | 24165 | Values: 1200.1 1322.2 1333.2 1396.8 1715.4 7511.7 7704.7 7727.6 7747.3 7763.6 7642.2 7774.1 7839.8 7843.0 7843.6 2178.3 2217.9 2223.2 2226.8 2239.2 2220.8 2226.1 2273.4 2282.2 2286.6 2065.1 2073.5 2076.0 2128.1 2208.4 2237.7 2238.0 2250.2 2252.5 2263.1 2257.9 2262.8 2266.2 2281.8 2282.6 7908.2 7944.6 7955.4 7957.2 7965.2 4390.7 4507.2 4512.3 4518.1 4527.4 2776.8 2808.6 2814.7 2815.1 2828.7 876.2 884.3 890.1 904.2 941.3 10946.7 10947.0 10948.9 10956.6 11003.4 4102.1 4166.6 4243.1 4253.7 4258.0 9182.5 9254.9 9256.9 9278.4 9278.4 4419.3 4430.0 4451.8 4458.5 4465.9 3493.4 3920.1 4031.8 4032.3 4039.6 3573.6 3614.8 3622.0 3659.2 3659.4 1156.1 1161.8 1165.5 1169.8 1178.8 1158.8 1161.8 1167.6 1179.3 1181.5 7485.4 7496.3 7548.2 7556.2 7603.2 453.0 454.5 456.8 457.2 474.7 5275.4 5302.2 5309.7 5337.4 5369.7 9412.5 9677.7 9948.3 9985.3 10034.9 9705.9 9827.6 9847.5 9862.8 9886.4 7154.2 7254.5 7315.8 7321.9 7332.1 7188.6 7196.8 7201.0 7246.2 7252.1 8663.3 8677.3 8915.7 8933.3 8938.7 8835.9 8942.1 8965.7 9114.5 9118.4 5582.2 6340.6 6474.5 6662.3 6761.8 7242.5 7244.3 7265.9 7274.7 7276.3 6374.1 6411.7 6478.1 6496.2 6532.2 6165.5 6517.0 6526.7 6570.7 6627.3 6862.2 6865.3 6909.8 6922.7 6929.1 6204.4 6254.3 6291.3 6465.3 6487.7 6617.9 6632.0 6646.7 6647.9 6691.7 11:19:51 INFO - PROCESS | 24165 | 11:19:51 INFO - PROCESS | 24165 | [#4] prototype.html Cycles:180 Average:4770.50 Median:5404.32 stddev:1392.32 (25.8%) stddev-sans-first:1355.74 11:19:51 INFO - PROCESS | 24165 | Values: 329.6 331.1 334.7 336.2 344.4 5394.4 5417.5 5421.7 5442.5 5515.6 5401.4 5402.0 5403.5 5405.1 5415.2 4081.5 4159.9 4232.8 4261.1 4276.1 4254.6 4284.2 4304.4 4312.9 4316.9 4227.9 4268.2 4272.2 4273.3 4274.3 4038.3 4167.3 4262.1 4267.7 4272.1 3781.0 3783.4 3788.8 3791.0 3795.6 5209.6 5215.2 5219.5 5220.1 5221.5 4911.4 4916.3 4918.9 4919.7 4924.1 5703.0 5707.7 5709.1 5710.5 5727.9 3866.4 4135.1 4157.2 4161.6 4161.7 5934.9 5980.1 6002.1 6021.4 6025.2 4129.9 4133.2 4135.2 4135.7 4142.5 4174.0 4181.6 4192.6 4194.6 4200.3 4774.9 4800.0 4802.3 4802.6 4803.9 5719.8 5726.9 5732.7 5734.5 5740.3 1414.5 1461.0 1483.0 1488.2 1495.4 927.5 954.3 993.4 1004.5 1010.5 5095.9 5102.0 5118.2 5129.6 5132.3 5871.3 5934.1 5952.8 5957.1 5958.2 5083.6 5085.1 5097.1 5100.6 5105.1 3114.5 3178.6 3183.8 3185.9 3186.5 5657.1 5657.5 5673.3 5676.8 5679.1 5988.3 6037.3 6037.7 6039.0 6051.8 5629.1 5654.5 5664.5 5666.5 5673.5 5813.9 5854.1 5866.8 5877.7 5880.1 5741.8 5745.5 5746.8 5755.2 5761.3 5537.1 5628.3 5648.0 5659.0 5672.8 4027.8 4049.8 4078.9 4084.3 4112.7 5979.7 5988.3 5989.6 5996.2 5999.7 5755.7 5756.2 5766.0 5767.7 5770.3 5730.6 5753.0 5765.0 5769.3 5774.1 5477.8 5639.8 5644.3 5647.9 5670.2 5803.9 5826.6 5831.6 5832.5 5834.5 5631.6 5635.7 5636.1 5651.5 5652.5 11:19:51 INFO - PROCESS | 24165 | 11:19:51 INFO - PROCESS | 24165 | [#5] yui.html Cycles:180 Average:12467.33 Median:25003.31 stddev:14429.44 (57.7%) stddev-sans-first:14442.17 11:19:51 INFO - PROCESS | 24165 | Values: 551.7 574.8 630.2 630.4 639.2 11048.4 12267.8 12475.3 12486.8 12498.4 11969.4 12036.2 12042.7 12069.6 12086.9 691.7 829.4 837.0 853.2 853.8 779.9 784.1 785.3 787.6 788.0 864.7 867.7 869.8 870.6 870.9 724.2 854.2 855.2 861.6 878.4 647.1 655.8 655.9 656.2 656.4 11083.9 11117.8 11199.4 11220.0 11241.8 11593.5 12033.8 12246.9 12266.8 12285.8 9545.5 9750.9 9773.1 9785.9 9923.1 3324.2 3327.9 3370.2 3373.2 3398.7 41436.4 43232.8 43694.0 43896.6 43929.1 9481.4 9564.7 9591.4 9605.6 9689.8 15607.8 15608.9 15628.5 15681.1 15682.5 6117.9 6223.7 6557.7 6659.7 6764.7 3515.6 3578.3 3583.1 3589.1 3607.8 2777.9 2816.1 2818.5 2819.2 2825.6 497.4 521.7 523.9 528.5 529.7 431.9 443.7 500.8 502.8 518.1 6709.0 6774.1 6802.4 6895.1 6936.7 420.4 448.7 507.9 520.9 521.8 3221.7 3230.5 3239.0 3338.0 3344.1 48773.8 49509.3 52285.7 52773.0 53555.7 42084.2 42713.8 42719.8 43004.1 43355.0 42973.8 43113.1 43333.6 43710.3 43985.6 7824.3 7826.8 7888.2 8142.2 8158.2 32178.5 32565.7 33183.3 33820.0 34723.5 42036.6 42528.6 42830.1 43106.4 43111.0 10404.7 10428.2 10506.4 10579.2 10644.0 10707.9 11517.1 11565.5 11623.3 11763.8 9088.2 10167.8 10201.8 10713.1 10876.9 9022.9 9279.0 9506.3 9637.6 9850.1 9065.8 9359.1 9362.0 9700.8 10801.7 9099.9 9267.0 9297.5 9299.7 9474.8 8531.8 8579.9 8623.2 8723.0 8891.1 11:19:51 INFO - PROCESS | 24165 | -------- Summary: end -------- 11:19:51 INFO - PROCESS | 24165 | 11:19:51 INFO - TEST-INFO | 24165: exit 0 11:19:51 INFO - TEST-OK | dromaeo_css | took 1115958ms 11:19:51 INFO - TEST-START | kraken 11:19:51 INFO - operating with platform_type : linux_ 11:19:51 INFO - Initialising browser for kraken test... 11:19:51 INFO - TEST-INFO | started process 24360 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaFSJZP/profile http://localhost:35291/getInfo.html) 11:19:56 INFO - PROCESS | 24360 | __metrics Screen width/height:1600/1200 11:19:56 INFO - PROCESS | 24360 | colorDepth:24 11:19:56 INFO - PROCESS | 24360 | Browser inner width/height: 1024/697 11:19:56 INFO - PROCESS | 24360 | __metrics 11:19:57 INFO - PROCESS | 24360 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:19:58 INFO - TEST-INFO | 24360: exit 0 11:19:58 INFO - Browser initialized. 11:19:58 INFO - Running cycle 1/1 for kraken test... 11:19:58 INFO - TEST-INFO | started process 24449 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaFSJZP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:20:10 INFO - PROCESS | 24449 | RSS: Main: 137986048 11:20:10 INFO - PROCESS | 24449 | 11:20:13 INFO - PROCESS | 24449 | Cycle 1(1): loaded http://localhost:35291/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35291/tests/kraken/driver.html?testName=audio-beat-detection) 11:20:13 INFO - PROCESS | 24449 | RSS: Main: 183554048 11:20:13 INFO - PROCESS | 24449 | 11:20:16 INFO - PROCESS | 24449 | Cycle 1(1): loaded http://localhost:35291/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35291/tests/kraken/driver.html?testName=audio-dft) 11:20:17 INFO - PROCESS | 24449 | RSS: Main: 175583232 11:20:17 INFO - PROCESS | 24449 | 11:20:19 INFO - PROCESS | 24449 | Cycle 1(1): loaded http://localhost:35291/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35291/tests/kraken/driver.html?testName=audio-fft) 11:20:20 INFO - PROCESS | 24449 | RSS: Main: 175038464 11:20:20 INFO - PROCESS | 24449 | 11:20:22 INFO - PROCESS | 24449 | Cycle 1(1): loaded http://localhost:35291/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35291/tests/kraken/driver.html?testName=audio-oscillator) 11:20:23 INFO - PROCESS | 24449 | RSS: Main: 175759360 11:20:23 INFO - PROCESS | 24449 | 11:20:25 INFO - PROCESS | 24449 | Cycle 1(1): loaded http://localhost:35291/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35291/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:20:26 INFO - PROCESS | 24449 | RSS: Main: 175181824 11:20:26 INFO - PROCESS | 24449 | 11:20:29 INFO - PROCESS | 24449 | Cycle 1(1): loaded http://localhost:35291/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35291/tests/kraken/driver.html?testName=imaging-darkroom) 11:20:29 INFO - PROCESS | 24449 | RSS: Main: 174313472 11:20:29 INFO - PROCESS | 24449 | 11:20:33 INFO - PROCESS | 24449 | Cycle 1(1): loaded http://localhost:35291/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35291/tests/kraken/driver.html?testName=imaging-desaturate) 11:20:33 INFO - PROCESS | 24449 | RSS: Main: 174518272 11:20:33 INFO - PROCESS | 24449 | 11:20:36 INFO - PROCESS | 24449 | Cycle 1(1): loaded http://localhost:35291/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35291/tests/kraken/driver.html?testName=json-parse-financial) 11:20:36 INFO - PROCESS | 24449 | RSS: Main: 174362624 11:20:36 INFO - PROCESS | 24449 | 11:20:38 INFO - PROCESS | 24449 | Cycle 1(1): loaded http://localhost:35291/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35291/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:20:39 INFO - PROCESS | 24449 | RSS: Main: 180002816 11:20:39 INFO - PROCESS | 24449 | 11:20:41 INFO - PROCESS | 24449 | Cycle 1(1): loaded http://localhost:35291/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35291/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:20:41 INFO - PROCESS | 24449 | RSS: Main: 179593216 11:20:41 INFO - PROCESS | 24449 | 11:20:43 INFO - PROCESS | 24449 | Cycle 1(1): loaded http://localhost:35291/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35291/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:20:44 INFO - PROCESS | 24449 | RSS: Main: 184709120 11:20:44 INFO - PROCESS | 24449 | 11:20:46 INFO - PROCESS | 24449 | Cycle 1(1): loaded http://localhost:35291/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35291/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:20:47 INFO - PROCESS | 24449 | RSS: Main: 188502016 11:20:47 INFO - PROCESS | 24449 | 11:20:49 INFO - PROCESS | 24449 | Cycle 1(1): loaded http://localhost:35291/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35291/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:20:50 INFO - PROCESS | 24449 | RSS: Main: 186642432 11:20:50 INFO - PROCESS | 24449 | 11:20:52 INFO - PROCESS | 24449 | Cycle 1(1): loaded http://localhost:35291/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35291/tests/kraken/driver.html?testName=ai-astar) 11:20:52 INFO - PROCESS | 24449 | RSS: Main: 248455168 11:20:52 INFO - PROCESS | 24449 | 11:20:52 INFO - PROCESS | 24449 | __start_tp_report 11:20:52 INFO - PROCESS | 24449 | _x_x_mozilla_page_load 11:20:52 INFO - PROCESS | 24449 | _x_x_mozilla_page_load_details 11:20:52 INFO - PROCESS | 24449 | |i|pagename|runs| 11:20:52 INFO - PROCESS | 24449 | |0;ai-astar;113;114;114;115;113;112;114;113;113;126 11:20:52 INFO - PROCESS | 24449 | |1;audio-beat-detection;160;138;156;178;138;155;155;133;174;132 11:20:52 INFO - PROCESS | 24449 | |2;audio-dft;161;161;162;161;161;161;160;160;162;161 11:20:52 INFO - PROCESS | 24449 | |3;audio-fft;75;74;78;163;75;74;77;75;155;76 11:20:52 INFO - PROCESS | 24449 | |4;audio-oscillator;103;99;142;94;95;94;148;93;96;130 11:20:52 INFO - PROCESS | 24449 | |5;imaging-gaussian-blur;116;117;117;117;116;117;117;117;117;117 11:20:52 INFO - PROCESS | 24449 | |6;imaging-darkroom;147;147;148;147;148;147;147;148;147;145 11:20:52 INFO - PROCESS | 24449 | |7;imaging-desaturate;96;95;95;94;95;95;95;95;95;95 11:20:52 INFO - PROCESS | 24449 | |8;json-parse-financial;66;66;66;65;67;66;66;67;80;65 11:20:52 INFO - PROCESS | 24449 | |9;json-stringify-tinderbox;64;65;64;65;65;66;72;65;64;64 11:20:52 INFO - PROCESS | 24449 | |10;stanford-crypto-aes;81;81;83;81;81;89;81;82;80;81 11:20:52 INFO - PROCESS | 24449 | |11;stanford-crypto-ccm;126;117;120;120;125;122;127;115;117;118 11:20:52 INFO - PROCESS | 24449 | |12;stanford-crypto-pbkdf2;134;151;143;143;146;133;144;136;132;155 11:20:52 INFO - PROCESS | 24449 | |13;stanford-crypto-sha256-iterative;69;70;69;69;70;70;67;69;67;67 11:20:52 INFO - PROCESS | 24449 | __end_tp_report 11:20:52 INFO - PROCESS | 24449 | __start_cc_report 11:20:52 INFO - PROCESS | 24449 | _x_x_mozilla_cycle_collect,1087 11:20:52 INFO - PROCESS | 24449 | __end_cc_report 11:20:52 INFO - PROCESS | 24449 | __startTimestamp1467224452547__endTimestamp 11:20:52 INFO - PROCESS | 24449 | 11:20:52 INFO - PROCESS | 24449 | ------- Summary: start ------- 11:20:52 INFO - PROCESS | 24449 | Number of tests: 14 11:20:52 INFO - PROCESS | 24449 | 11:20:52 INFO - PROCESS | 24449 | [#0] ai-astar Cycles:10 Average:114.70 Median:114.00 stddev:4.06 (3.6%) stddev-sans-first:4.26 11:20:52 INFO - PROCESS | 24449 | Values: 113.0 114.0 114.0 115.0 113.0 112.0 114.0 113.0 113.0 126.0 11:20:52 INFO - PROCESS | 24449 | 11:20:52 INFO - PROCESS | 24449 | [#1] audio-beat-detection Cycles:10 Average:151.90 Median:155.50 stddev:16.37 (10.5%) stddev-sans-first:17.10 11:20:52 INFO - PROCESS | 24449 | Values: 160.0 138.0 156.0 178.0 138.0 155.0 155.0 133.0 174.0 132.0 11:20:52 INFO - PROCESS | 24449 | 11:20:52 INFO - PROCESS | 24449 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 11:20:52 INFO - PROCESS | 24449 | Values: 161.0 161.0 162.0 161.0 161.0 161.0 160.0 160.0 162.0 161.0 11:20:52 INFO - PROCESS | 24449 | 11:20:52 INFO - PROCESS | 24449 | [#3] audio-fft Cycles:10 Average:92.20 Median:75.00 stddev:35.28 (47.0%) stddev-sans-first:36.87 11:20:52 INFO - PROCESS | 24449 | Values: 75.0 74.0 78.0 163.0 75.0 74.0 77.0 75.0 155.0 76.0 11:20:52 INFO - PROCESS | 24449 | 11:20:52 INFO - PROCESS | 24449 | [#4] audio-oscillator Cycles:10 Average:109.40 Median:94.00 stddev:21.75 (23.1%) stddev-sans-first:22.94 11:20:52 INFO - PROCESS | 24449 | Values: 103.0 99.0 142.0 94.0 95.0 94.0 148.0 93.0 96.0 130.0 11:20:52 INFO - PROCESS | 24449 | 11:20:52 INFO - PROCESS | 24449 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 11:20:52 INFO - PROCESS | 24449 | Values: 116.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 11:20:52 INFO - PROCESS | 24449 | 11:20:52 INFO - PROCESS | 24449 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 11:20:52 INFO - PROCESS | 24449 | Values: 147.0 147.0 148.0 147.0 148.0 147.0 147.0 148.0 147.0 145.0 11:20:52 INFO - PROCESS | 24449 | 11:20:52 INFO - PROCESS | 24449 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 11:20:52 INFO - PROCESS | 24449 | Values: 96.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 11:20:52 INFO - PROCESS | 24449 | 11:20:52 INFO - PROCESS | 24449 | [#8] json-parse-financial Cycles:10 Average:67.40 Median:66.00 stddev:4.48 (6.8%) stddev-sans-first:4.72 11:20:52 INFO - PROCESS | 24449 | Values: 66.0 66.0 66.0 65.0 67.0 66.0 66.0 67.0 80.0 65.0 11:20:52 INFO - PROCESS | 24449 | 11:20:52 INFO - PROCESS | 24449 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.00 stddev:2.41 (3.7%) stddev-sans-first:2.51 11:20:52 INFO - PROCESS | 24449 | Values: 64.0 65.0 64.0 65.0 65.0 66.0 72.0 65.0 64.0 64.0 11:20:52 INFO - PROCESS | 24449 | 11:20:52 INFO - PROCESS | 24449 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:81.00 stddev:2.58 (3.2%) stddev-sans-first:2.71 11:20:52 INFO - PROCESS | 24449 | Values: 81.0 81.0 83.0 81.0 81.0 89.0 81.0 82.0 80.0 81.0 11:20:52 INFO - PROCESS | 24449 | 11:20:52 INFO - PROCESS | 24449 | [#11] stanford-crypto-ccm Cycles:10 Average:120.70 Median:121.00 stddev:4.16 (3.4%) stddev-sans-first:3.95 11:20:52 INFO - PROCESS | 24449 | Values: 126.0 117.0 120.0 120.0 125.0 122.0 127.0 115.0 117.0 118.0 11:20:52 INFO - PROCESS | 24449 | 11:20:52 INFO - PROCESS | 24449 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.70 Median:143.50 stddev:7.83 (5.5%) stddev-sans-first:7.80 11:20:52 INFO - PROCESS | 24449 | Values: 134.0 151.0 143.0 143.0 146.0 133.0 144.0 136.0 132.0 155.0 11:20:52 INFO - PROCESS | 24449 | 11:20:52 INFO - PROCESS | 24449 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:1.25 (1.8%) stddev-sans-first:1.32 11:20:52 INFO - PROCESS | 24449 | Values: 69.0 70.0 69.0 69.0 70.0 70.0 67.0 69.0 67.0 67.0 11:20:52 INFO - PROCESS | 24449 | -------- Summary: end -------- 11:20:52 INFO - PROCESS | 24449 | 11:20:53 INFO - TEST-INFO | 24449: exit 0 11:20:53 INFO - TEST-OK | kraken | took 61400ms 11:20:53 INFO - SUITE-END | took 1177s 11:20:53 INFO - Completed test suite (00:19:37) 11:20:53 INFO - javascript benchmark 11:20:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2778.9861050694744, 2855.4289142171556, 2868.8135271207357, 2888.0, 2896.449674561833, 4702.0360826030665, 4732.10090082884, 4739.715617062979, 4749.913986965908, 4768.070226305867, 4730.929036064454, 4737.526247375269, 4758.238681810911, 4760.547747963947, 4791.353167322411, 4103.281925663012, 4270.743755374672, 4349.0432104936945, 4363.803628836694, 4406.250937340644, 4278.893027674318, 4285.807138678767, 4360.672949528782, 4419.558044195571, 4467.642588592921, 4325.870223893288, 4421.137878113769, 4421.9336709949375, 4441.689081764278, 4464.776761161945, 4357.520672725997, 4375.58431948966, 4408.206522825906, 4411.250087485103, 4423.336499525065, 4183.748975061506, 4237.682173836944, 4321.049369138785, 4337.262665346867, 4345.826166953318, 4553.4991150973365, 4557.703749256288, 4573.885652858672, 4578.748168850712, 4586.128635559233, 4928.088303663798, 4935.210366341368, 4938.061768264054, 4946.1344264753525, 4958.925616115761, 4859.538343857328, 5041.747912604392, 5088.389393272794, 5117.360329958755, 5134.281200631877, 4585.839495617637, 4603.792829322689, 4611.677182597253, 4621.21439355307, 4645.256758918556, 4986.90026199474, 5032.974835125874, 5060.468650791614, 5062.7468626568525, 5064.620153488503, 4910.386201724785, 4953.8513844583995, 4991.301217829507, 4995.250712393097, 4995.675281106789, 5019.372578427697, 5026.89946201074, 5030.119729047402, 5032.949670503322, 5066.088104141216, 4788.353572267769, 4953.43035550909, 4976.4525902150735, 4990.4011518618, 5018.372703412074, 4833.927491087637, 4902.41171059468, 4962.7022378656675, 4969.577585905166, 5012.874678133003, 4242.0, 4260.339647354665, 4263.275243208662, 4284.207421627009, 4290.935635965463, 3638.690711289517, 3753.6246375362794, 3793.506844110248, 3795.013296542919, 3821.2548553031893, 4422.800973956179, 4425.734455932655, 4428.579284967923, 4443.622292105143, 4454.554544545585, 5006.849794506171, 5025.949740502621, 5029.622778291643, 5030.144875371196, 5045.310308468235, 4276.615104640598, 4389.166058448948, 4412.933805992912, 4443.777811109496, 4459.175052615276, 4516.051629157913, 4542.545745425497, 4550.863474095782, 4553.4991150973365, 4565.497795242521, 4855.223164293696, 4857.587105096036, 4862.41651001882, 4879.316895634685, 4908.092002979461, 4916.287138364989, 5000.649954503296, 5058.190689489811, 5080.847574572768, 5081.974590127025, 4845.709257444564, 4846.660733748745, 4854.538818812349, 4869.245266983623, 4900.019996000886, 4962.950370496249, 4963.528464795839, 4975.6019518437715, 4990.525900039491, 5012.097822392005, 4810.182269014206, 5047.192449208109, 5095.923561146512, 5113.463086376026, 5116.411612664591, 4839.177339852163, 4890.144224760724, 4892.510748925079, 4899.265110233494, 4920.581750551243, 4729.858104256878, 4864.270359446112, 4897.461279259207, 4902.779374928208, 4920.6801557898625, 4686.156491831503, 4744.074905393415, 4783.832565860178, 4807.687500312469, 4819.493953135011, 4888.071266459504, 4966.900661986812, 4967.950320496749, 4968.527989840959, 4991.5008499151245, 4818.349522814376, 4834.8791280218275, 4846.806127754991, 4856.344393506973, 4882.853514394574], "unit": "score", "name": "dojo.html", "value": 4633.9114204501}, {"lowerIsBetter": false, "replicates": [508.8422588997411, 518.6887867279631, 519.7557148140378, 526.5050852198933, 551.3659291814414, 27554.86222568887, 34630.480542791876, 35195.296094078134, 35251.82374088132, 35292.0, 37418.4387234191, 37922.0, 37948.0, 37949.81025094871, 37986.24027519448, 7816.491928024674, 8030.397720170981, 8030.9196908031045, 8032.799180020517, 8034.5982700865015, 7909.525428474281, 8038.954935858359, 8046.114927358015, 8052.315553177987, 8054.718084867001, 8019.799505012392, 8265.545395003272, 8308.916910830874, 8317.29303009242, 8323.750287491355, 8189.385796065319, 8266.751997440026, 8273.089960104413, 8275.586220688941, 8275.917240827575, 8159.592020399015, 8296.253337199621, 8296.419250652456, 8297.377696672773, 8314.62584183707, 38142.0, 38485.80757096224, 38511.03722406934, 38596.61403385958, 38717.80641096805, 2654.3762215879447, 2693.3266683329166, 2746.1898739871785, 2869.899553515617, 3006.8045577037424, 28696.0, 29230.0, 29274.121776346532, 29289.70710292891, 29359.70640293591, 3112.7821052526333, 3116.4234616596004, 3142.685731426862, 3176.174194709369, 3227.9677203227902, 230975.0, 231286.0, 231768.0, 232004.0, 232097.83951080305, 54150.18774718382, 54184.0, 54461.0, 54749.0, 54768.45231547713, 62187.0, 63787.0, 63796.68101659462, 63813.36186638074, 63916.68041659855, 11292.37891915936, 11351.091912646969, 11422.200445968703, 11461.770764584828, 11469.082473402108, 8755.168259015383, 8781.91218087811, 8791.340649451316, 8812.559372031374, 8818.29453643707, 19359.51601209981, 19738.40784776459, 19795.901020495094, 20396.592068158552, 20583.279585214445, 7069.363757261871, 7167.89248161278, 7227.89158162628, 7268.454865884974, 7329.633518324063, 904.1681652879366, 917.4311926605413, 934.4299977014152, 986.0041358228098, 1028.7222449938474, 26999.865000675265, 27146.0, 27295.86352068227, 27695.169144925683, 27767.722322776917, 918.6141820435299, 1015.7816069544936, 1035.9847349597437, 1062.2776511971779, 1089.4226060188114, 12137.501061581668, 12559.246445213317, 12662.113652044269, 12666.0, 12699.746005079847, 285243.0, 288576.0, 288648.0, 289174.0, 289655.0, 47875.0, 48168.518314817105, 48409.0, 48409.515904840504, 48524.0, 1150.9942450287695, 1203.8194270859442, 1248.3945286536023, 1252.2861968677948, 1287.7617640736494, 23955.520889581763, 24879.875600621883, 26785.0, 27015.59476607813, 27031.72968270292, 38022.61977380191, 38270.42594361031, 38308.23383532258, 38353.80823095867, 38383.0, 189980.0, 190950.0, 191099.0, 191498.0, 191831.0, 31289.8435507821, 31518.0, 31777.364452711277, 31898.84050579732, 32068.35863282768, 40949.795251023555, 41117.58882411257, 41540.79229603833, 42151.0, 42320.788396057826, 34389.484157737155, 34566.65433345635, 34575.0, 34646.0, 34698.0, 34470.65529344775, 34964.30071398507, 35139.29721405506, 35247.82376088103, 35457.0, 32200.35599288048, 32417.513737293488, 33256.50115248225, 36095.0, 36444.0, 31796.04611861648, 32720.83639581882, 32846.34307313793, 33205.169870752456, 33293.33413331671, 25552.361190970376, 25605.231843044738, 26354.86822565875, 26367.675645654017, 28355.82615248839], "unit": "score", "name": "ext.html", "value": 16845.99698766424}, {"lowerIsBetter": false, "replicates": [347.95302634144383, 358.4748343676514, 359.3495772651501, 362.619249787723, 363.14298256115546, 15611.687766244668, 16004.201722309763, 16327.591810204736, 16788.83211167888, 16829.579260518494, 12712.872871271284, 14009.439622415091, 14421.711565768705, 14538.927305363484, 14540.0, 5023.29673845661, 5097.949020509803, 5153.098207813637, 5159.174532074869, 5184.196449550326, 5015.623828212881, 5031.748412579374, 5135.58915286778, 5182.922256166161, 5195.506426889458, 5137.229415587673, 5137.691738495683, 5138.537531622153, 5140.588752899777, 5147.716875571842, 5123.308353372285, 5173.3533308336455, 5392.110301800199, 5403.540699040566, 5406.378266499363, 5149.665271757323, 5173.793048278064, 5181.611379146579, 5189.065968125736, 5193.428722840485, 12889.548865789746, 19167.424977250706, 19963.0, 20047.198112075646, 20052.899735501374, 1780.5993651428455, 1787.195761907134, 1788.9016104114269, 1851.1022154255174, 1856.4894653970132, 9491.715248542554, 9501.097395747393, 9534.856977145348, 9605.423674579548, 11763.35301558414, 1717.9570510737205, 1724.8188940161353, 1826.2147276671026, 1863.1150203653156, 1898.0880356027726, 34866.0, 45515.54484455146, 50229.18697358256, 56548.71725641387, 57113.0, 9268.119528644902, 9407.670731524364, 9494.477803720862, 9596.040395960348, 9597.952010239904, 11859.644210673694, 13014.21914685122, 13041.347932603521, 13063.216207027419, 13095.0, 6146.293176284695, 6333.588316759396, 6403.071554624554, 6408.10286559882, 6466.159399278064, 6000.559865632217, 6026.668533230714, 6080.027195648763, 6085.026395776655, 6106.053561697855, 4091.91816163681, 4093.16090201508, 4111.691623128278, 4122.2579935611875, 4178.561251068655, 1732.237815361237, 1743.389813565242, 1752.1502071495315, 1770.1237887245895, 1788.3740690758132, 802.7792357101844, 805.1867613710195, 835.5488036460243, 869.5826003518221, 940.4874343482818, 15220.0, 15599.844001559839, 15844.53961883657, 16319.83680163183, 16442.83557164437, 856.3834039491556, 867.8871746672892, 884.7345796261096, 899.8335307968047, 967.8161149381594, 9065.138811812867, 9110.81778364429, 9280.814383712288, 9390.953045234866, 9454.716358509255, 365502.0, 367310.0, 369472.0, 378743.0, 387082.0, 66973.0, 68034.65982670055, 68244.3175568238, 68818.0, 69569.65215173892, 831.5592735850009, 882.3602887906345, 892.906244844295, 917.0691747875911, 918.6141820435433, 14140.43438262458, 14420.134791912518, 15360.0, 15409.537713868602, 15511.301991410639, 32538.674613253563, 32791.34417311688, 33328.66671333255, 33387.1653208662, 33651.66348336583, 41334.0, 41383.586164137974, 41648.375274371516, 41718.374224386054, 42875.5712442884, 7550.320471157403, 7561.810954726176, 7637.5799331035105, 7662.157162711986, 7700.19147989453, 8655.826883462421, 10754.300970436896, 11500.367479788692, 11617.128715346214, 11646.534138634359, 9322.906770932204, 10036.949815250877, 10200.744981375525, 10229.386236825814, 10404.739881503023, 9986.800263994824, 9996.700098997042, 10106.292559520763, 10139.087482126644, 10193.727626226715, 9697.806043879224, 10325.9483702581, 10350.223733219887, 10420.895791041992, 10429.63496277657, 7590.620468976639, 7648.34989025939, 7766.262205090507, 7833.529988200727, 7987.800304992422, 9516.952415238156, 10071.0, 10174.23693223026, 10246.180305575685, 10314.484275786332], "unit": "score", "name": "jquery.html", "value": 7757.344308552572}, {"lowerIsBetter": false, "replicates": [1200.1299058182813, 1322.1538215542053, 1333.1601091312473, 1396.8323801143865, 1715.3996101364517, 7511.661975211115, 7704.730334438295, 7727.574983375919, 7747.341475974535, 7763.611819409028, 7642.197569255231, 7774.105977812554, 7839.843203135933, 7842.960785196066, 7843.607819609011, 2178.335607639673, 2217.8558393704357, 2223.188536184289, 2226.8441209115285, 2239.2274665240466, 2220.7779222077743, 2226.0984301357976, 2273.4089136824377, 2282.2126366403645, 2286.6455699366543, 2065.070718176819, 2073.4712648274667, 2075.9584808303825, 2128.095559387262, 2208.447888027993, 2237.697910782048, 2237.9888100559556, 2250.189931624614, 2252.4594097416666, 2263.128695452246, 2257.932262032142, 2262.7963483286417, 2266.172846910882, 2281.7946384825277, 2282.6119559674894, 7908.169642187545, 7944.642491087915, 7955.4033447491665, 7957.2042795720545, 7965.163657815961, 4390.736555806662, 4507.166174257773, 4512.278035514335, 4518.1415531049, 4527.366168736379, 2776.7917406194615, 2808.620836187109, 2814.704456032108, 2815.0569559197693, 2828.702986186441, 876.1676407412983, 884.2704768565959, 890.1365675294953, 904.1817155474306, 941.3269512298739, 10946.671599851938, 10947.0, 10948.945255273753, 10956.616518421897, 11003.394813285266, 4102.138550904284, 4166.58334166587, 4243.130158317537, 4253.744775313491, 4257.978710106491, 9182.540872956326, 9254.907450925539, 9256.90743092574, 9278.350515463853, 9278.396904201205, 4419.337099435111, 4430.047539778963, 4451.7996690148375, 4458.509563947963, 4465.888352791206, 3493.3711931852004, 3920.0591857953887, 4031.838726450968, 4032.334664780278, 4039.5758445363404, 3573.6426357364576, 3614.7831130132276, 3621.9858439636946, 3659.1949771050326, 3659.396199627085, 1156.1213477756964, 1161.7676464707092, 1165.5221359242669, 1169.7601991591703, 1178.7878181927335, 1158.7982832618093, 1161.79668558002, 1167.6146871532374, 1179.2688533109356, 1181.509673485494, 7485.363744081814, 7496.325330720261, 7548.245175482408, 7556.206598307209, 7603.239676032463, 453.0, 454.4773510462994, 456.82183948260206, 457.2158747747629, 474.71042663974947, 5275.419703832576, 5302.1781623848365, 5309.734513274321, 5337.386200586904, 5369.677819330853, 9412.482313472688, 9677.70966870995, 9948.303618746619, 9985.251106167067, 10034.949825250973, 9705.9029409705, 9827.606895724233, 9847.458389788488, 9862.802743945082, 9886.406815591088, 7154.177269614061, 7254.455915806336, 7315.780526584104, 7321.926780732125, 7332.0834895638045, 7188.640567971476, 7196.820079498055, 7201.0, 7246.239144889711, 7252.129744430702, 8663.263622591898, 8677.349198810241, 8915.687950921687, 8933.28533717314, 8938.731838044869, 8835.911640883765, 8942.105789421006, 8965.686200982935, 9114.453132812052, 9118.361714679908, 5582.162675598693, 6340.587861788969, 6474.4820414365795, 6662.267150613332, 6761.763338283136, 7242.493025488166, 7244.275572442713, 7265.854682906418, 7274.709011639687, 7276.345128938421, 6374.107624932421, 6411.743530258737, 6478.060681201294, 6496.220453545605, 6532.216134063943, 6165.506759459322, 6516.967415162894, 6526.706298216686, 6570.704318305592, 6627.304133065959, 6862.176538815374, 6865.347791959756, 6909.827254318682, 6922.688479018356, 6929.133858267716, 6204.410580994799, 6254.343293954069, 6291.339409362135, 6465.288818230085, 6487.675616219076, 6617.933820661732, 6631.972044333136, 6646.700898459678, 6647.9002814958785, 6691.698873550605], "unit": "score", "name": "mootools.html", "value": 4296.599007464657}, {"lowerIsBetter": false, "replicates": [329.5748484455053, 331.0614408152886, 334.7088033410933, 336.15960099750623, 344.419652884889, 5394.352677678679, 5417.458254174586, 5421.701806400646, 5442.455754424555, 5515.641483303582, 5401.378841433237, 5401.972990135054, 5403.5136837684695, 5405.135178371462, 5415.187721841726, 4081.510218773751, 4159.854405095823, 4232.76719780412, 4261.126469073833, 4276.080642661819, 4254.574542545752, 4284.164587905359, 4304.375865499516, 4312.935305970397, 4316.870493885189, 4227.85202517912, 4268.210381079494, 4272.209641216369, 4273.273543497613, 4274.273373526508, 4038.3336749436307, 4167.312393455076, 4262.1049579588325, 4267.722598031118, 4272.124214536044, 3780.981095094507, 3783.375743002401, 3788.78758797185, 3791.0332865119217, 3795.6394142556414, 5209.583233341324, 5215.217717342391, 5219.478052194788, 5220.086484865134, 5221.477852214748, 4911.386076740408, 4916.287138364953, 4918.926216106761, 4919.72941488218, 4924.064427758714, 5702.971485142589, 5707.71461426927, 5709.115087161496, 5710.457506536873, 5727.914081288784, 3866.420036994445, 4135.110951145488, 4157.230912281208, 4161.646260067898, 4161.709869940328, 5934.910976335358, 5980.1328807323125, 6002.129691194796, 6021.3677563856045, 6025.216721826135, 4129.855455059119, 4133.173365326947, 4135.214309281287, 4135.669146468275, 4142.46148000758, 4174.039970806732, 4181.623653871166, 4192.580741925783, 4194.643455306272, 4200.348945913388, 4774.928376074292, 4799.9760001199775, 4802.27965805125, 4802.615790736802, 4803.879903002383, 5719.799807006735, 5726.942730572724, 5732.6847023413275, 5734.512566431817, 5740.339860915965, 1414.5332040426636, 1460.978085328721, 1482.9629259268604, 1488.1517535004944, 1495.3943652820626, 927.5130556457779, 954.3271993244746, 993.3642468819961, 1004.5429329655135, 1010.540204207084, 5095.8980820383385, 5102.0, 5118.155504341742, 5129.563987061067, 5132.28148059272, 5871.295444546682, 5934.080217566284, 5952.761889524457, 5957.076653118774, 5958.225430693982, 5083.593312534988, 5085.110105731556, 5097.133487307166, 5100.591952643779, 5105.106606343949, 3114.5483904834127, 3178.6026746656667, 3183.8248896310924, 3185.8566364513654, 3186.490161574137, 5657.066584013674, 5657.547396208376, 5673.31920169574, 5676.77292908279, 5679.119736440858, 5988.3113441953865, 6037.305709843425, 6037.72830222641, 6038.973374526341, 6051.8487037823525, 5629.099344104923, 5654.547636189095, 5664.461876121762, 5666.518345940559, 5673.517750991212, 5813.883722325614, 5854.092615644582, 5866.794662186803, 5877.735501902339, 5880.117982302689, 5741.770329186786, 5745.454181852718, 5746.770129194785, 5755.1942728017275, 5761.337446193741, 5537.086380747131, 5628.268325117709, 5648.0, 5659.0, 5672.7730890763905, 4027.8187481562813, 4049.757014579017, 4078.877633670995, 4084.346504559256, 4112.670986321147, 5979.701014949148, 5988.341282458839, 5989.64062156272, 5996.220491336273, 5999.730012149376, 5755.683437410982, 5756.1941328214925, 5765.971170144123, 5767.68277744728, 5770.307563092456, 5730.570207234391, 5752.993226185485, 5765.0, 5769.336526299529, 5774.133879918046, 5477.835664930059, 5639.830805075854, 5644.322681278273, 5647.915281270702, 5670.206171135962, 5803.8549036274435, 5826.592138550261, 5831.562632802472, 5832.533397328289, 5834.474897259267, 5631.63394379364, 5635.718214089197, 5636.070048441961, 5651.491365777099, 5652.519535839335], "unit": "score", "name": "prototype.html", "value": 4327.049655148667}, {"lowerIsBetter": false, "replicates": [551.7489542258272, 574.7729646789518, 630.1618846933579, 630.4483576870238, 639.2201514152732, 11048.447577621117, 12267.815982760265, 12475.251484910912, 12486.81269780954, 12498.437570309336, 11969.401529923512, 12036.157468977175, 12042.69893252667, 12069.577564785235, 12086.939565302184, 691.6507163882233, 829.4194064155085, 836.9958150209255, 853.189470003496, 853.8078932240259, 779.9220077992184, 784.051297929506, 785.3246208260891, 787.6140691061368, 788.0189164490217, 864.6714248585529, 867.6919693508809, 869.7825543614097, 870.5864714260707, 870.9129087091272, 724.2395484741028, 854.2354592639584, 855.1875718067861, 861.5993562993176, 878.3982971664367, 647.1069923505532, 655.806537071565, 655.9245686746037, 656.238763034882, 656.4420242793635, 11083.944580277048, 11117.777644447066, 11199.384033878134, 11220.0, 11241.775164496665, 11593.478293476814, 12033.819492707617, 12246.877531224663, 12266.81599776004, 12285.754284914341, 9545.522723863849, 9750.90249097507, 9773.07155820196, 9785.902140978642, 9923.057309555581, 3324.2188085799817, 3327.866885324584, 3370.2416956184907, 3373.1904342957514, 3398.728101751854, 41436.378454322905, 43232.78383608093, 43694.0, 43896.56103438957, 43929.12141757147, 9481.383710058824, 9564.66523671682, 9591.376560523684, 9605.615775369046, 9689.757756056155, 15607.843921560867, 15608.921955390151, 15628.453004145027, 15681.05913645185, 15682.451114210948, 6117.938820611826, 6223.657698826608, 6557.672116394161, 6659.700313485808, 6764.695588698521, 3515.5605549306338, 3578.3380074686265, 3583.104223944014, 3589.0847833802213, 3607.8376473058775, 2777.9444411111663, 2816.084772448962, 2818.506761316761, 2819.210621026116, 2825.57616357548, 497.36585853036945, 521.705236541353, 523.8926020165857, 528.4556906386429, 529.6821906855855, 431.8790738593199, 443.66946624764114, 500.82971789591716, 502.79636747117473, 518.082993102207, 6709.0, 6774.119364482585, 6802.387785099266, 6895.138107736533, 6936.722531098801, 420.3904338708823, 448.70385545539784, 507.8699892738701, 520.8906129712802, 521.804323378733, 3221.7100460958627, 3230.466972949437, 3238.9838050809594, 3337.9666203338143, 3344.1138098403944, 48773.75613121912, 49509.257361139615, 52285.7385713069, 52773.0, 53555.73222133942, 42084.15831683349, 42713.78643106827, 42719.78640106842, 43004.13991720148, 43355.0, 42973.78513107477, 43113.13773724508, 43333.566664333586, 43710.344344834855, 43985.56014439878, 7824.334931530656, 7826.843463130592, 7888.171741967011, 8142.18578142181, 8158.224968627971, 32178.517322239717, 32565.674343256265, 33183.33633327272, 33820.0, 34723.479147813305, 42036.57963420449, 42528.57471425246, 42830.14339713126, 43106.353404698326, 43111.0, 10404.73988150272, 10428.217883658908, 10506.369617822955, 10579.206559508222, 10644.0, 10707.946460267649, 11517.136214783757, 11565.537378504765, 11623.302601843916, 11763.823542646696, 9088.182063614306, 10167.847482287623, 10201.846972295272, 10713.089387402159, 10876.945615271872, 9022.90977090247, 9279.0, 9506.334556580972, 9637.614495420105, 9850.113489785954, 9065.773355665897, 9359.110884465965, 9361.953190234006, 9700.75748106303, 10801.729956751144, 9099.909000909905, 9266.9536652319, 9297.535123243946, 9299.72100836976, 9474.810503790024, 8531.829363412573, 8579.914200857911, 8623.180797824196, 8723.040465548658, 8891.110888911317], "unit": "score", "name": "yui.html", "value": 5668.288414819433}], "name": "dromaeo_css", "value": 6321.613153620382}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 114.0, 114.0, 115.0, 113.0, 112.0, 114.0, 113.0, 113.0, 126.0], "unit": "score", "name": "ai-astar", "value": 114.7}, {"lowerIsBetter": true, "replicates": [160.0, 138.0, 156.0, 178.0, 138.0, 155.0, 155.0, 133.0, 174.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 151.9}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 162.0, 161.0, 161.0, 161.0, 160.0, 160.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [75.0, 74.0, 78.0, 163.0, 75.0, 74.0, 77.0, 75.0, 155.0, 76.0], "unit": "score", "name": "audio-fft", "value": 92.2}, {"lowerIsBetter": true, "replicates": [103.0, 99.0, 142.0, 94.0, 95.0, 94.0, 148.0, 93.0, 96.0, 130.0], "unit": "score", "name": "audio-oscillator", "value": 109.4}, {"lowerIsBetter": true, "replicates": [116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.8}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 148.0, 147.0, 148.0, 147.0, 147.0, 148.0, 147.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 147.1}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.0}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 66.0, 65.0, 67.0, 66.0, 66.0, 67.0, 80.0, 65.0], "unit": "score", "name": "json-parse-financial", "value": 67.4}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 64.0, 65.0, 65.0, 66.0, 72.0, 65.0, 64.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.4}, {"lowerIsBetter": true, "replicates": [81.0, 81.0, 83.0, 81.0, 81.0, 89.0, 81.0, 82.0, 80.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.0}, {"lowerIsBetter": true, "replicates": [126.0, 117.0, 120.0, 120.0, 125.0, 122.0, 127.0, 115.0, 117.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.7}, {"lowerIsBetter": true, "replicates": [134.0, 151.0, 143.0, 143.0, 146.0, 133.0, 144.0, 136.0, 132.0, 155.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.7}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 69.0, 69.0, 70.0, 70.0, 67.0, 69.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.7}], "name": "kraken", "value": 1534.0000000000002}]} 11:20:53 INFO - Return code: 0 11:20:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:20:53 INFO - # TBPL SUCCESS # 11:20:53 INFO - Running post-action listener: _resource_record_post_action 11:20:53 INFO - Running post-run listener: _resource_record_post_run 11:20:54 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 16384; Write bytes: 485691392; Read time: 36; Write time: 904112 11:20:54 INFO - install - Wall time: 15s; CPU: 17.0%; Read bytes: 0; Write bytes: 238448640; Read time: 0; Write time: 626280 11:20:54 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 16384; Write bytes: 247242752; Read time: 36; Write time: 277832 11:20:54 INFO - Running post-run listener: _upload_blobber_files 11:20:54 INFO - Blob upload gear active. 11:20:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:20:54 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 11:20:54 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', 'Larch-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:20:54 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 Larch-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:20:55 INFO - (blobuploader) - INFO - Open directory for files ... 11:20:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:20:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:20:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:20:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:20:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:20:56 INFO - (blobuploader) - INFO - Done attempting. 11:20:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:20:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:20:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:20:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:20:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:20:56 INFO - (blobuploader) - INFO - Done attempting. 11:20:56 INFO - (blobuploader) - INFO - Iteration through files over. 11:20:56 INFO - Return code: 0 11:20:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:20:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:20:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/081b0c67b6932d6377d8a381961172b2796adfe19050b4b1250424167b2ea0a792f41d3f8f78fa041ae071720dacab994f62dc0a802195812afb8aaf0b427e8c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/fa488a15272ece1b18918596022e6ecb374f73bcef9ac263774fbefd00e2cbbf268e9923ddefa48d98658b965fcffdaa4ff0dd676ffc65b101f7d3dcd5d54057"} 11:20:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:20:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:20:56 INFO - Contents: 11:20:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/081b0c67b6932d6377d8a381961172b2796adfe19050b4b1250424167b2ea0a792f41d3f8f78fa041ae071720dacab994f62dc0a802195812afb8aaf0b427e8c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/fa488a15272ece1b18918596022e6ecb374f73bcef9ac263774fbefd00e2cbbf268e9923ddefa48d98658b965fcffdaa4ff0dd676ffc65b101f7d3dcd5d54057"} 11:20:56 INFO - Running post-run listener: copy_logs_to_upload_dir 11:20:56 INFO - Copying logs to upload dir... 11:20:56 INFO - mkdir: /builds/slave/test/build/upload/logs 11:20:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.800550 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-06-29 11:20:56.534974) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 11:20:56.538985) ========= 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=af724c981e2a0f424dbabf99000001e7-1467223223.290504-140936659 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/081b0c67b6932d6377d8a381961172b2796adfe19050b4b1250424167b2ea0a792f41d3f8f78fa041ae071720dacab994f62dc0a802195812afb8aaf0b427e8c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/fa488a15272ece1b18918596022e6ecb374f73bcef9ac263774fbefd00e2cbbf268e9923ddefa48d98658b965fcffdaa4ff0dd676ffc65b101f7d3dcd5d54057"} build_url:https://queue.taskcluster.net/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011181 build_url: 'https://queue.taskcluster.net/v1/task/ZvtAdJJSRf-L9kDnIYrKoA/artifacts/public/build/firefox-47.0.2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/081b0c67b6932d6377d8a381961172b2796adfe19050b4b1250424167b2ea0a792f41d3f8f78fa041ae071720dacab994f62dc0a802195812afb8aaf0b427e8c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/fa488a15272ece1b18918596022e6ecb374f73bcef9ac263774fbefd00e2cbbf268e9923ddefa48d98658b965fcffdaa4ff0dd676ffc65b101f7d3dcd5d54057"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 11:20:56.568110) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 11:20:56.568450) ========= 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=af724c981e2a0f424dbabf99000001e7-1467223223.290504-140936659 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004463 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 11:20:56.653276) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 11:20:56.653999) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 11:20:56.654447) ========= ========= Total master_lag: 0.17 =========