builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-058 starttime: 1461610718.25 results: success (0) buildid: 20160425101116 builduid: 446384ecbf1f4bdaa704342431d2371d revision: 2045bc8c9e90a7ca0b8c6447ddecd812a71b29e1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 11:58:38.255215) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 11:58:38.255672) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 11:58:38.255952) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 11:58:38.276715) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 11:58:38.276999) ========= 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=0e2a256762fed810e2f0f810000001b3-1461610254.908545-2104960304 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-25 11:58:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 219M=0s 2016-04-25 11:58:38 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.381880 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 11:58:38.674799) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 11:58:38.675356) ========= 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=0e2a256762fed810e2f0f810000001b3-1461610254.908545-2104960304 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018122 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 11:58:38.726844) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 11:58:38.727211) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2045bc8c9e90a7ca0b8c6447ddecd812a71b29e1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 2045bc8c9e90a7ca0b8c6447ddecd812a71b29e1 --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=0e2a256762fed810e2f0f810000001b3-1461610254.908545-2104960304 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-25 11:58:38,810 truncating revision to first 12 chars 2016-04-25 11:58:38,810 Setting DEBUG logging. 2016-04-25 11:58:38,810 attempt 1/10 2016-04-25 11:58:38,810 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2045bc8c9e90?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-25 11:58:39,024 unpacking tar archive at: mozilla-central-2045bc8c9e90/testing/mozharness/ program finished with exit code 0 elapsedTime=0.469007 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 11:58:39.208929) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 11:58:39.209272) ========= script_repo_revision: 2045bc8c9e90a7ca0b8c6447ddecd812a71b29e1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 11:58:39.209669) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 11:58:39.209940) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 11:58:39.219970) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-04-25 11:58:39.220250) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=0e2a256762fed810e2f0f810000001b3-1461610254.908545-2104960304 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:58:39 INFO - MultiFileLogger online at 20160425 11:58:39 in /builds/slave/test 11:58:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 11:58:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:58:39 INFO - {'append_to_log': False, 11:58:39 INFO - 'base_work_dir': '/builds/slave/test', 11:58:39 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 11:58:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:58:39 INFO - 'branch': 'Firefox-Non-PGO', 11:58:39 INFO - 'buildbot_json_path': 'buildprops.json', 11:58:39 INFO - 'config_files': ('talos/linux_config.py',), 11:58:39 INFO - 'default_actions': ('clobber', 11:58:39 INFO - 'read-buildbot-config', 11:58:39 INFO - 'download-and-extract', 11:58:39 INFO - 'populate-webroot', 11:58:39 INFO - 'create-virtualenv', 11:58:39 INFO - 'install', 11:58:39 INFO - 'run-tests'), 11:58:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:58:39 INFO - 'download_minidump_stackwalk': True, 11:58:39 INFO - 'download_symbols': 'ondemand', 11:58:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:58:39 INFO - 'tooltool.py': '/tools/tooltool.py', 11:58:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:58:39 INFO - '/tools/misc-python/virtualenv.py')}, 11:58:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:58:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:58:39 INFO - 'installer_path': 'installer.exe', 11:58:39 INFO - 'log_level': 'info', 11:58:39 INFO - 'log_name': 'talos', 11:58:39 INFO - 'log_to_console': True, 11:58:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:58:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:58:39 INFO - 'opt_config_files': (), 11:58:39 INFO - 'pip_index': False, 11:58:39 INFO - 'sps_profile': False, 11:58:39 INFO - 'sps_profile_interval': 0, 11:58:39 INFO - 'suite': 'dromaeojs', 11:58:39 INFO - 'system_bits': '32', 11:58:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:58:39 INFO - 'title': 'talos-linux64-ix-058', 11:58:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:58:39 INFO - 'use_talos_json': True, 11:58:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:58:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:58:39 INFO - 'work_dir': 'build'} 11:58:39 INFO - ##### 11:58:39 INFO - ##### Running clobber step. 11:58:39 INFO - ##### 11:58:39 INFO - Running pre-action listener: _resource_record_pre_action 11:58:39 INFO - Running main action method: clobber 11:58:39 INFO - rmtree: /builds/slave/test/build 11:58:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:58:40 INFO - Running post-action listener: _resource_record_post_action 11:58:40 INFO - ##### 11:58:40 INFO - ##### Running read-buildbot-config step. 11:58:40 INFO - ##### 11:58:40 INFO - Running pre-action listener: _resource_record_pre_action 11:58:40 INFO - Running main action method: read_buildbot_config 11:58:40 INFO - Using buildbot properties: 11:58:40 INFO - { 11:58:40 INFO - "project": "", 11:58:40 INFO - "product": "firefox", 11:58:40 INFO - "script_repo_revision": "production", 11:58:40 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 11:58:40 INFO - "repository": "", 11:58:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 11:58:40 INFO - "buildid": "20160425101116", 11:58:40 INFO - "pgo_build": "False", 11:58:40 INFO - "basedir": "/builds/slave/test", 11:58:40 INFO - "buildnumber": 484, 11:58:40 INFO - "slavename": "talos-linux64-ix-058", 11:58:40 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:58:40 INFO - "platform": "ubuntu64_hw", 11:58:40 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 11:58:40 INFO - "branch": "mozilla-central", 11:58:40 INFO - "repo_path": "mozilla-central", 11:58:40 INFO - "revision": "2045bc8c9e90a7ca0b8c6447ddecd812a71b29e1", 11:58:40 INFO - "stage_platform": "linux64", 11:58:40 INFO - "builduid": "446384ecbf1f4bdaa704342431d2371d", 11:58:40 INFO - "slavebuilddir": "test" 11:58:40 INFO - } 11:58:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/FvDwgoaJSAKnQ9PG_3oVmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 11:58:40 INFO - Running post-action listener: _resource_record_post_action 11:58:40 INFO - ##### 11:58:40 INFO - ##### Running download-and-extract step. 11:58:40 INFO - ##### 11:58:40 INFO - Running pre-action listener: _resource_record_pre_action 11:58:40 INFO - Running main action method: download_and_extract 11:58:40 INFO - mkdir: /builds/slave/test/build/tests 11:58: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:58:40 INFO - https://queue.taskcluster.net/v1/task/FvDwgoaJSAKnQ9PG_3oVmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:58:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FvDwgoaJSAKnQ9PG_3oVmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:58:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FvDwgoaJSAKnQ9PG_3oVmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:58:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FvDwgoaJSAKnQ9PG_3oVmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:58:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FvDwgoaJSAKnQ9PG_3oVmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:58:41 INFO - Downloaded 1361 bytes. 11:58:41 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:58:41 INFO - Using the following test package requirements: 11:58:41 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:58:41 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:58:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:58:41 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:58:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:58:41 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:58:41 INFO - u'jsshell-linux-x86_64.zip'], 11:58:41 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:58:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:58:41 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:58:41 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:58:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:58:41 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:58:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:58:41 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:58:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:58:41 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:58:41 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:58:41 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:58:41 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:58:41 INFO - https://queue.taskcluster.net/v1/task/FvDwgoaJSAKnQ9PG_3oVmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:58:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FvDwgoaJSAKnQ9PG_3oVmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:58:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FvDwgoaJSAKnQ9PG_3oVmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:58:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FvDwgoaJSAKnQ9PG_3oVmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:58:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FvDwgoaJSAKnQ9PG_3oVmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:58:45 INFO - Downloaded 22287736 bytes. 11:58:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:58:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:58:46 INFO - Return code: 0 11:58:46 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:58: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:58:46 INFO - https://queue.taskcluster.net/v1/task/FvDwgoaJSAKnQ9PG_3oVmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:58:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FvDwgoaJSAKnQ9PG_3oVmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:58:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FvDwgoaJSAKnQ9PG_3oVmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:58:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FvDwgoaJSAKnQ9PG_3oVmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:58:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FvDwgoaJSAKnQ9PG_3oVmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:58:49 INFO - Downloaded 22287736 bytes. 11:58:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:58:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:58:50 INFO - Return code: 0 11:58:50 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:58:50 INFO - https://queue.taskcluster.net/v1/task/FvDwgoaJSAKnQ9PG_3oVmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:58:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FvDwgoaJSAKnQ9PG_3oVmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:58:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FvDwgoaJSAKnQ9PG_3oVmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:58:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FvDwgoaJSAKnQ9PG_3oVmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:58:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FvDwgoaJSAKnQ9PG_3oVmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:58:51 INFO - Downloaded 10840145 bytes. 11:58:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:58:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:58:52 INFO - Return code: 0 11:58:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:58:52 INFO - https://queue.taskcluster.net/v1/task/FvDwgoaJSAKnQ9PG_3oVmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:58:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FvDwgoaJSAKnQ9PG_3oVmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:58:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FvDwgoaJSAKnQ9PG_3oVmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:58:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FvDwgoaJSAKnQ9PG_3oVmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:58:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FvDwgoaJSAKnQ9PG_3oVmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:58:53 INFO - Downloaded 54808313 bytes. 11:58:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FvDwgoaJSAKnQ9PG_3oVmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:58:53 INFO - mkdir: /builds/slave/test/properties 11:58:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:58:53 INFO - Writing to file /builds/slave/test/properties/build_url 11:58:53 INFO - Contents: 11:58:53 INFO - build_url:https://queue.taskcluster.net/v1/task/FvDwgoaJSAKnQ9PG_3oVmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:58:54 INFO - Running post-action listener: _resource_record_post_action 11:58:54 INFO - Running post-action listener: set_extra_try_arguments 11:58:54 INFO - ##### 11:58:54 INFO - ##### Running populate-webroot step. 11:58:54 INFO - ##### 11:58:54 INFO - Running pre-action listener: _resource_record_pre_action 11:58:54 INFO - Running main action method: populate_webroot 11:58:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:58:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:58:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:58:54 INFO - '--tppagecycles', 11:58:54 INFO - '7'], 11:58:54 INFO - 'tests': ['tsvgm']}}, 11:58:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:58:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:58:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:58:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:58:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:58:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:58:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:58:54 INFO - 'talos_options': ['--disable-e10s'], 11:58:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:58:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:58:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:58:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:58:54 INFO - 'talos_options': ['--disable-e10s'], 11:58:54 INFO - 'tests': ['damp', 'tps']}, 11:58:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:58:54 INFO - 'tests': ['damp', 'tps']}, 11:58:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:58:54 INFO - 'tests': ['dromaeo_dom']}, 11:58:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:58:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:58:54 INFO - 'tests': ['a11yr', 11:58:54 INFO - 'ts_paint', 11:58:54 INFO - 'tpaint', 11:58:54 INFO - 'sessionrestore', 11:58:54 INFO - 'sessionrestore_no_auto_restore', 11:58:54 INFO - 'tabpaint']}, 11:58:54 INFO - 'other-e10s': {'tests': ['a11yr', 11:58:54 INFO - 'ts_paint', 11:58:54 INFO - 'tpaint', 11:58:54 INFO - 'sessionrestore', 11:58:54 INFO - 'sessionrestore_no_auto_restore', 11:58:54 INFO - 'tabpaint']}, 11:58:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:58:54 INFO - 'ts_paint', 11:58:54 INFO - 'tpaint', 11:58:54 INFO - 'sessionrestore', 11:58:54 INFO - 'sessionrestore_no_auto_restore', 11:58:54 INFO - 'tabpaint']}, 11:58:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:58:54 INFO - 'ts_paint', 11:58:54 INFO - 'tpaint', 11:58:54 INFO - 'sessionrestore', 11:58:54 INFO - 'sessionrestore_no_auto_restore', 11:58:54 INFO - 'tabpaint']}, 11:58:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:58:54 INFO - 'tests': ['a11yr', 11:58:54 INFO - 'ts_paint', 11:58:54 INFO - 'tpaint', 11:58:54 INFO - 'sessionrestore', 11:58:54 INFO - 'sessionrestore_no_auto_restore', 11:58:54 INFO - 'tabpaint']}, 11:58:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:58:54 INFO - 'tests': ['a11yr', 11:58:54 INFO - 'ts_paint', 11:58:54 INFO - 'tpaint', 11:58:54 INFO - 'sessionrestore', 11:58:54 INFO - 'sessionrestore_no_auto_restore', 11:58:54 INFO - 'tabpaint']}, 11:58:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:58:54 INFO - 'tests': ['tsvgx', 11:58:54 INFO - 'tsvgr_opacity', 11:58:54 INFO - 'tart', 11:58:54 INFO - 'tscrollx', 11:58:54 INFO - 'cart']}, 11:58:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:58:54 INFO - 'tsvgr_opacity', 11:58:54 INFO - 'tart', 11:58:54 INFO - 'tscrollx', 11:58:54 INFO - 'cart']}, 11:58:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:58:54 INFO - 'talos_options': ['--disable-e10s'], 11:58:54 INFO - 'tests': ['tp5o']}, 11:58:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:58:54 INFO - 'tests': ['tp5o']}, 11:58:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:58:54 INFO - 'talos_options': ['--disable-e10s', 11:58:54 INFO - '--xperf_path', 11:58:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:58:54 INFO - 'tests': ['tp5n']}, 11:58:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:58:54 INFO - 'talos_options': ['--xperf_path', 11:58:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:58:54 INFO - 'tests': ['tp5n']}}, 11:58:54 INFO - 'talos.zip': {'path': '', 11:58:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:58:54 INFO - Running post-action listener: _resource_record_post_action 11:58:54 INFO - ##### 11:58:54 INFO - ##### Running create-virtualenv step. 11:58:54 INFO - ##### 11:58:54 INFO - Running pre-action listener: _resource_record_pre_action 11:58:54 INFO - Running main action method: create_virtualenv 11:58:54 INFO - Creating virtualenv /builds/slave/test/build/venv 11:58:54 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:58:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:58:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:58:54 INFO - Using real prefix '/usr' 11:58:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:58:55 INFO - Installing distribute.............................................................................................................................................................................................done. 11:58:57 INFO - Installing pip.................done. 11:58:57 INFO - Return code: 0 11:58:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:58:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:58:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96605cdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10385a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7410>, '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 0x10c8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c87a0>, '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': '0e2a256762fed810e2f0f810000001b3-1461610254.908545-2104960304', '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:58:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:58:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:58:57 INFO - Using env: {'DISPLAY': ':0', 11:58:57 INFO - 'HOME': '/home/cltbld', 11:58:57 INFO - 'LANG': 'en_US.UTF-8', 11:58:57 INFO - 'LANGUAGE': 'en_US:en', 11:58:57 INFO - 'LOGNAME': 'cltbld', 11:58:57 INFO - 'MAIL': '/var/mail/cltbld', 11:58:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:57 INFO - 'MOZ_NO_REMOTE': '1', 11:58:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:58:57 INFO - 'NO_EM_RESTART': '1', 11:58:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:58:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:57 INFO - 'PWD': '/builds/slave/test', 11:58:57 INFO - 'SHELL': '/bin/bash', 11:58:57 INFO - 'SHLVL': '1', 11:58:57 INFO - 'TERM': 'linux', 11:58:57 INFO - 'TMOUT': '86400', 11:58:57 INFO - 'USER': 'cltbld', 11:58:57 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461610254.908545-2104960304', 11:58:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:57 INFO - '_': '/tools/buildbot/bin/python'} 11:58:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:57 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:58:57 INFO - Cleaning up... 11:58:57 INFO - Return code: 0 11:58:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:58:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:58:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f96605cdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10385a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7410>, '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 0x10c8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c87a0>, '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': '0e2a256762fed810e2f0f810000001b3-1461610254.908545-2104960304', '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:58:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 11:58:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 11:58:57 INFO - Using env: {'DISPLAY': ':0', 11:58:57 INFO - 'HOME': '/home/cltbld', 11:58:57 INFO - 'LANG': 'en_US.UTF-8', 11:58:57 INFO - 'LANGUAGE': 'en_US:en', 11:58:57 INFO - 'LOGNAME': 'cltbld', 11:58:57 INFO - 'MAIL': '/var/mail/cltbld', 11:58:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:57 INFO - 'MOZ_NO_REMOTE': '1', 11:58:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:58:57 INFO - 'NO_EM_RESTART': '1', 11:58:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:58:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:57 INFO - 'PWD': '/builds/slave/test', 11:58:57 INFO - 'SHELL': '/bin/bash', 11:58:57 INFO - 'SHLVL': '1', 11:58:57 INFO - 'TERM': 'linux', 11:58:57 INFO - 'TMOUT': '86400', 11:58:57 INFO - 'USER': 'cltbld', 11:58:57 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461610254.908545-2104960304', 11:58:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:57 INFO - '_': '/tools/buildbot/bin/python'} 11:58:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:57 INFO - Downloading/unpacking psutil>=0.7.1 11:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:58:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:58:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:58:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:58:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:58:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:58:59 INFO - Installing collected packages: psutil 11:58:59 INFO - Running setup.py install for psutil 11:58:59 INFO - building 'psutil._psutil_linux' extension 11:58:59 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:58:59 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:58:59 INFO - building 'psutil._psutil_posix' extension 11:58:59 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:58:59 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:59:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:59:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:59:00 INFO - Successfully installed psutil 11:59:00 INFO - Cleaning up... 11:59:00 INFO - Return code: 0 11:59:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:59:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:59:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f96605cdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10385a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7410>, '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 0x10c8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c87a0>, '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': '0e2a256762fed810e2f0f810000001b3-1461610254.908545-2104960304', '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:59:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 11:59:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 11:59:00 INFO - Using env: {'DISPLAY': ':0', 11:59:00 INFO - 'HOME': '/home/cltbld', 11:59:00 INFO - 'LANG': 'en_US.UTF-8', 11:59:00 INFO - 'LANGUAGE': 'en_US:en', 11:59:00 INFO - 'LOGNAME': 'cltbld', 11:59:00 INFO - 'MAIL': '/var/mail/cltbld', 11:59:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:00 INFO - 'MOZ_NO_REMOTE': '1', 11:59:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:59:00 INFO - 'NO_EM_RESTART': '1', 11:59:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:59:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:00 INFO - 'PWD': '/builds/slave/test', 11:59:00 INFO - 'SHELL': '/bin/bash', 11:59:00 INFO - 'SHLVL': '1', 11:59:00 INFO - 'TERM': 'linux', 11:59:00 INFO - 'TMOUT': '86400', 11:59:00 INFO - 'USER': 'cltbld', 11:59:00 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461610254.908545-2104960304', 11:59:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:00 INFO - '_': '/tools/buildbot/bin/python'} 11:59:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:59:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:59:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:59:02 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:59:02 INFO - Installing collected packages: mozsystemmonitor 11:59:02 INFO - Running setup.py install for mozsystemmonitor 11:59:02 INFO - Successfully installed mozsystemmonitor 11:59:02 INFO - Cleaning up... 11:59:02 INFO - Return code: 0 11:59:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:59:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:59:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:59:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f96605cdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10385a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7410>, '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 0x10c8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c87a0>, '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': '0e2a256762fed810e2f0f810000001b3-1461610254.908545-2104960304', '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:59:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:59:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:59:02 INFO - Using env: {'DISPLAY': ':0', 11:59:02 INFO - 'HOME': '/home/cltbld', 11:59:02 INFO - 'LANG': 'en_US.UTF-8', 11:59:02 INFO - 'LANGUAGE': 'en_US:en', 11:59:02 INFO - 'LOGNAME': 'cltbld', 11:59:02 INFO - 'MAIL': '/var/mail/cltbld', 11:59:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:02 INFO - 'MOZ_NO_REMOTE': '1', 11:59:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:59:02 INFO - 'NO_EM_RESTART': '1', 11:59:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:59:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:02 INFO - 'PWD': '/builds/slave/test', 11:59:02 INFO - 'SHELL': '/bin/bash', 11:59:02 INFO - 'SHLVL': '1', 11:59:02 INFO - 'TERM': 'linux', 11:59:02 INFO - 'TMOUT': '86400', 11:59:02 INFO - 'USER': 'cltbld', 11:59:02 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461610254.908545-2104960304', 11:59:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:02 INFO - '_': '/tools/buildbot/bin/python'} 11:59:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:02 INFO - Downloading/unpacking blobuploader==1.2.4 11:59:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:59:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:59:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:04 INFO - Downloading blobuploader-1.2.4.tar.gz 11:59:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:59:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:59:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:59:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:59:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:05 INFO - Downloading docopt-0.6.1.tar.gz 11:59:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:59:05 INFO - Installing collected packages: blobuploader, requests, docopt 11:59:05 INFO - Running setup.py install for blobuploader 11:59:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:59:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:59:06 INFO - Running setup.py install for requests 11:59:06 INFO - Running setup.py install for docopt 11:59:06 INFO - Successfully installed blobuploader requests docopt 11:59:06 INFO - Cleaning up... 11:59:06 INFO - Return code: 0 11:59:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:59:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:59:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:06 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 0x7f96605cdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10385a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7410>, '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 0x10c8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c87a0>, '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': '0e2a256762fed810e2f0f810000001b3-1461610254.908545-2104960304', '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:59:06 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:59:06 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:59:06 INFO - Using env: {'DISPLAY': ':0', 11:59:06 INFO - 'HOME': '/home/cltbld', 11:59:06 INFO - 'LANG': 'en_US.UTF-8', 11:59:06 INFO - 'LANGUAGE': 'en_US:en', 11:59:06 INFO - 'LOGNAME': 'cltbld', 11:59:06 INFO - 'MAIL': '/var/mail/cltbld', 11:59:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:06 INFO - 'MOZ_NO_REMOTE': '1', 11:59:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:59:06 INFO - 'NO_EM_RESTART': '1', 11:59:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:59:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:06 INFO - 'PWD': '/builds/slave/test', 11:59:06 INFO - 'SHELL': '/bin/bash', 11:59:06 INFO - 'SHLVL': '1', 11:59:06 INFO - 'TERM': 'linux', 11:59:06 INFO - 'TMOUT': '86400', 11:59:06 INFO - 'USER': 'cltbld', 11:59:06 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461610254.908545-2104960304', 11:59:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:06 INFO - '_': '/tools/buildbot/bin/python'} 11:59:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:59:06 INFO - Running setup.py (path:/tmp/pip-_MxFiu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:59:07 INFO - Running setup.py (path:/tmp/pip-Qa5o7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:59:07 INFO - Running setup.py (path:/tmp/pip-2JIGSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:59:07 INFO - Running setup.py (path:/tmp/pip-jfG54h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:59:07 INFO - Running setup.py (path:/tmp/pip-gvBCxz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:59:07 INFO - Running setup.py (path:/tmp/pip-IyPzOX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:59:07 INFO - Running setup.py (path:/tmp/pip-zrECdZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:59:07 INFO - Running setup.py (path:/tmp/pip-v91k2F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:59:07 INFO - Running setup.py (path:/tmp/pip-iw69X5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:59:07 INFO - Running setup.py (path:/tmp/pip-8lWKVj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:59:07 INFO - Running setup.py (path:/tmp/pip-ORNjgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:59:07 INFO - Running setup.py (path:/tmp/pip-NTYTS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:59:07 INFO - Running setup.py (path:/tmp/pip-nPVyMN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:59:07 INFO - Running setup.py (path:/tmp/pip-CQkL5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:59:07 INFO - Running setup.py (path:/tmp/pip-JyUDZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:59:08 INFO - Running setup.py (path:/tmp/pip-vvB4Sz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:59:08 INFO - Running setup.py (path:/tmp/pip-2DuXKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:59:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:59:08 INFO - Running setup.py install for manifestparser 11:59:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:59:08 INFO - Running setup.py install for mozcrash 11:59:08 INFO - Running setup.py install for mozdebug 11:59:08 INFO - Running setup.py install for mozdevice 11:59:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:59:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:59:08 INFO - Running setup.py install for mozfile 11:59:08 INFO - Running setup.py install for mozhttpd 11:59:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:59:08 INFO - Running setup.py install for mozinfo 11:59:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:59:08 INFO - Running setup.py install for mozInstall 11:59:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:59:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:59:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:59:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:59:08 INFO - Running setup.py install for mozleak 11:59:09 INFO - Running setup.py install for mozlog 11:59:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:59:09 INFO - Running setup.py install for moznetwork 11:59:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:59:09 INFO - Running setup.py install for mozprocess 11:59:09 INFO - Running setup.py install for mozprofile 11:59:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:59:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:59:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:59:09 INFO - Running setup.py install for mozrunner 11:59:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:59:09 INFO - Running setup.py install for mozscreenshot 11:59:09 INFO - Running setup.py install for moztest 11:59:09 INFO - Running setup.py install for mozversion 11:59:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:59:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:59:09 INFO - Cleaning up... 11:59:09 INFO - Return code: 0 11:59:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:59:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:59:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:59:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:09 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 0x7f96605cdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10385a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7410>, '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 0x10c8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c87a0>, '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': '0e2a256762fed810e2f0f810000001b3-1461610254.908545-2104960304', '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:59:09 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:59:09 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:59:09 INFO - Using env: {'DISPLAY': ':0', 11:59:09 INFO - 'HOME': '/home/cltbld', 11:59:09 INFO - 'LANG': 'en_US.UTF-8', 11:59:09 INFO - 'LANGUAGE': 'en_US:en', 11:59:09 INFO - 'LOGNAME': 'cltbld', 11:59:09 INFO - 'MAIL': '/var/mail/cltbld', 11:59:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:09 INFO - 'MOZ_NO_REMOTE': '1', 11:59:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:59:09 INFO - 'NO_EM_RESTART': '1', 11:59:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:59:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:09 INFO - 'PWD': '/builds/slave/test', 11:59:09 INFO - 'SHELL': '/bin/bash', 11:59:09 INFO - 'SHLVL': '1', 11:59:09 INFO - 'TERM': 'linux', 11:59:09 INFO - 'TMOUT': '86400', 11:59:09 INFO - 'USER': 'cltbld', 11:59:09 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461610254.908545-2104960304', 11:59:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:09 INFO - '_': '/tools/buildbot/bin/python'} 11:59:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:59:10 INFO - Running setup.py (path:/tmp/pip-LYn9Gk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:59:10 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:59:10 INFO - Running setup.py (path:/tmp/pip-2cAYNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:59:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:59:10 INFO - Running setup.py (path:/tmp/pip-Nu6IjY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:59:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:59:10 INFO - Running setup.py (path:/tmp/pip-qu2n15-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:59:10 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:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:59:10 INFO - Running setup.py (path:/tmp/pip-OFP7Zf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:59:10 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:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:59:10 INFO - Running setup.py (path:/tmp/pip-N5kdfp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:59:10 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:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:59:10 INFO - Running setup.py (path:/tmp/pip-sS69Sv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:59:10 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:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:59:10 INFO - Running setup.py (path:/tmp/pip-RmQO1Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:59:10 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:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:59:10 INFO - Running setup.py (path:/tmp/pip-MBJYKl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:59:10 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:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:59:10 INFO - Running setup.py (path:/tmp/pip-zf6XFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:59:10 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:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:59:10 INFO - Running setup.py (path:/tmp/pip-5vuOMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:59:10 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:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:59:10 INFO - Running setup.py (path:/tmp/pip-5X2n4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:59:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:59:11 INFO - Running setup.py (path:/tmp/pip-50JKsS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:59:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:59:11 INFO - Running setup.py (path:/tmp/pip-NZ3FQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:59:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:59:11 INFO - Running setup.py (path:/tmp/pip-mkhGeS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:59:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:59:11 INFO - Running setup.py (path:/tmp/pip-pXEKoQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:59:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:59:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:59:11 INFO - Running setup.py (path:/tmp/pip-gu8MEI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:59:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:59:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:59:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:59:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:59:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:59:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:59:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:59:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:13 INFO - Downloading blessings-1.6.tar.gz 11:59:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:59:13 INFO - Installing collected packages: blessings 11:59:13 INFO - Running setup.py install for blessings 11:59:13 INFO - Successfully installed blessings 11:59:13 INFO - Cleaning up... 11:59:13 INFO - Return code: 0 11:59:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:59:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:59:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:59:13 INFO - Reading from file tmpfile_stdout 11:59:13 INFO - Current package versions: 11:59:13 INFO - argparse == 1.2.1 11:59:13 INFO - blessings == 1.6 11:59:13 INFO - blobuploader == 1.2.4 11:59:13 INFO - docopt == 0.6.1 11:59:13 INFO - manifestparser == 1.1 11:59:13 INFO - mozInstall == 1.12 11:59:13 INFO - mozcrash == 0.17 11:59:13 INFO - mozdebug == 0.1 11:59:13 INFO - mozdevice == 0.48 11:59:13 INFO - mozfile == 1.2 11:59:13 INFO - mozhttpd == 0.7 11:59:13 INFO - mozinfo == 0.9 11:59:13 INFO - mozleak == 0.1 11:59:13 INFO - mozlog == 3.1 11:59:13 INFO - moznetwork == 0.27 11:59:13 INFO - mozprocess == 0.22 11:59:13 INFO - mozprofile == 0.28 11:59:13 INFO - mozrunner == 6.11 11:59:13 INFO - mozscreenshot == 0.1 11:59:13 INFO - mozsystemmonitor == 0.0 11:59:13 INFO - moztest == 0.7 11:59:13 INFO - mozversion == 1.4 11:59:13 INFO - psutil == 3.1.1 11:59:13 INFO - requests == 1.2.3 11:59:13 INFO - wsgiref == 0.1.2 11:59:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:59:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:59:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:59:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:13 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 0x7f96605cdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10385a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7410>, '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 0x10c8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c87a0>, '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': '0e2a256762fed810e2f0f810000001b3-1461610254.908545-2104960304', '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:59:13 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:59:13 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:59:13 INFO - Using env: {'DISPLAY': ':0', 11:59:13 INFO - 'HOME': '/home/cltbld', 11:59:13 INFO - 'LANG': 'en_US.UTF-8', 11:59:13 INFO - 'LANGUAGE': 'en_US:en', 11:59:13 INFO - 'LOGNAME': 'cltbld', 11:59:13 INFO - 'MAIL': '/var/mail/cltbld', 11:59:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:13 INFO - 'MOZ_NO_REMOTE': '1', 11:59:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:59:13 INFO - 'NO_EM_RESTART': '1', 11:59:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:59:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:13 INFO - 'PWD': '/builds/slave/test', 11:59:13 INFO - 'SHELL': '/bin/bash', 11:59:13 INFO - 'SHLVL': '1', 11:59:13 INFO - 'TERM': 'linux', 11:59:13 INFO - 'TMOUT': '86400', 11:59:13 INFO - 'USER': 'cltbld', 11:59:13 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461610254.908545-2104960304', 11:59:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:13 INFO - '_': '/tools/buildbot/bin/python'} 11:59:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:13 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:59:13 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:59:13 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:59:13 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:59:13 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:59:13 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:59:13 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:59:13 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:59:13 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:59:13 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:59:13 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:59:13 INFO - Cleaning up... 11:59:13 INFO - Return code: 0 11:59:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:59:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:59:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:59:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:13 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 0x7f96605cdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10385a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7410>, '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 0x10c8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c87a0>, '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': '0e2a256762fed810e2f0f810000001b3-1461610254.908545-2104960304', '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:59:13 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:59:13 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:59:13 INFO - Using env: {'DISPLAY': ':0', 11:59:13 INFO - 'HOME': '/home/cltbld', 11:59:13 INFO - 'LANG': 'en_US.UTF-8', 11:59:13 INFO - 'LANGUAGE': 'en_US:en', 11:59:13 INFO - 'LOGNAME': 'cltbld', 11:59:13 INFO - 'MAIL': '/var/mail/cltbld', 11:59:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:13 INFO - 'MOZ_NO_REMOTE': '1', 11:59:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:59:13 INFO - 'NO_EM_RESTART': '1', 11:59:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:59:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:13 INFO - 'PWD': '/builds/slave/test', 11:59:13 INFO - 'SHELL': '/bin/bash', 11:59:13 INFO - 'SHLVL': '1', 11:59:13 INFO - 'TERM': 'linux', 11:59:13 INFO - 'TMOUT': '86400', 11:59:13 INFO - 'USER': 'cltbld', 11:59:13 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461610254.908545-2104960304', 11:59:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:13 INFO - '_': '/tools/buildbot/bin/python'} 11:59:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:14 INFO - Downloading/unpacking jsonschema 11:59:14 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:59:14 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:59:14 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:59:14 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:59:14 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:59:14 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:59:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:59:16 INFO - Downloading/unpacking functools32 (from jsonschema) 11:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:59:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:16 INFO - Downloading functools32-3.2.3-2.tar.gz 11:59:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:59:16 INFO - warning: no files found matching '*.txt' 11:59:16 INFO - no previously-included directories found matching 'build' 11:59:16 INFO - no previously-included directories found matching 'dist' 11:59:16 INFO - no previously-included directories found matching '.git*' 11:59:16 INFO - Installing collected packages: jsonschema, functools32 11:59:16 INFO - Running setup.py install for functools32 11:59:16 INFO - warning: no files found matching '*.txt' 11:59:16 INFO - no previously-included directories found matching 'build' 11:59:16 INFO - no previously-included directories found matching 'dist' 11:59:16 INFO - no previously-included directories found matching '.git*' 11:59:16 INFO - Successfully installed jsonschema functools32 11:59:16 INFO - Cleaning up... 11:59:16 INFO - Return code: 0 11:59:16 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:59:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:59:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:59:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:59:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:59:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96605cdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf6d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10385a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7410>, '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 0x10c8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c87a0>, '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': '0e2a256762fed810e2f0f810000001b3-1461610254.908545-2104960304', '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:59:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 11:59:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 11:59:16 INFO - Using env: {'DISPLAY': ':0', 11:59:16 INFO - 'HOME': '/home/cltbld', 11:59:16 INFO - 'LANG': 'en_US.UTF-8', 11:59:16 INFO - 'LANGUAGE': 'en_US:en', 11:59:16 INFO - 'LOGNAME': 'cltbld', 11:59:16 INFO - 'MAIL': '/var/mail/cltbld', 11:59:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:16 INFO - 'MOZ_NO_REMOTE': '1', 11:59:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:59:16 INFO - 'NO_EM_RESTART': '1', 11:59:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:59:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:16 INFO - 'PWD': '/builds/slave/test', 11:59:16 INFO - 'SHELL': '/bin/bash', 11:59:16 INFO - 'SHLVL': '1', 11:59:16 INFO - 'TERM': 'linux', 11:59:16 INFO - 'TMOUT': '86400', 11:59:16 INFO - 'USER': 'cltbld', 11:59:16 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461610254.908545-2104960304', 11:59:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:16 INFO - '_': '/tools/buildbot/bin/python'} 11:59:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:59:16 INFO - Downloading/unpacking flake8 11:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:59:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:59:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:59:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:59:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:59:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:59:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:59:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:59:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:59:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:59:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:59:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:59:19 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:59:19 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:59:19 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:59:19 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:59:19 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:59:19 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:59:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:59:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:59:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:59:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:59:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:59:19 INFO - no previously-included directories found matching 'docs/_build' 11:59:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:59:19 INFO - Running setup.py install for pep8 11:59:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:59:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:59:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:59:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:59:19 INFO - no previously-included directories found matching 'docs/_build' 11:59:19 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:59:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:59:19 INFO - Cleaning up... 11:59:19 INFO - Return code: 0 11:59:19 INFO - Running post-action listener: _resource_record_post_action 11:59:19 INFO - Running post-action listener: _start_resource_monitoring 11:59:19 INFO - Starting resource monitoring. 11:59:19 INFO - ##### 11:59:19 INFO - ##### Running install step. 11:59:19 INFO - ##### 11:59:19 INFO - Running pre-action listener: _resource_record_pre_action 11:59:19 INFO - Running main action method: install 11:59:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:59:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:59:19 INFO - Reading from file tmpfile_stdout 11:59:19 INFO - Detecting whether we're running mozinstall >=1.0... 11:59:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:59:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:59:19 INFO - Reading from file tmpfile_stdout 11:59:19 INFO - Output received: 11:59:19 INFO - Usage: mozinstall [options] installer 11:59:19 INFO - Options: 11:59:19 INFO - -h, --help show this help message and exit 11:59:19 INFO - -d DEST, --destination=DEST 11:59:19 INFO - Directory to install application into. [default: 11:59:19 INFO - "/builds/slave/test"] 11:59:19 INFO - --app=APP Application being installed. [default: firefox] 11:59:19 INFO - mkdir: /builds/slave/test/build/application 11:59:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:59:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:59:35 INFO - Reading from file tmpfile_stdout 11:59:35 INFO - Output received: 11:59:35 INFO - /builds/slave/test/build/application/firefox/firefox 11:59:35 INFO - Running post-action listener: _resource_record_post_action 11:59:35 INFO - ##### 11:59:35 INFO - ##### Running run-tests step. 11:59:35 INFO - ##### 11:59:35 INFO - Running pre-action listener: _resource_record_pre_action 11:59:35 INFO - Running main action method: run_tests 11:59:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:59:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:59:35 INFO - Python 2.7.3 11:59:35 INFO - Return code: 0 11:59:35 INFO - grabbing minidump binary from tooltool 11:59:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:59:35 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7410>, '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 0x10c8310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c87a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:59:35 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:59:35 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:59:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:59:35 INFO - Return code: 0 11:59:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:59:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:59:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:59:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:59:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:59:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:59:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:59:36 INFO - Return code: 0 11:59:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FvDwgoaJSAKnQ9PG_3oVmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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:59:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FvDwgoaJSAKnQ9PG_3oVmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --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:59:36 INFO - Using env: {'DISPLAY': ':0', 11:59:36 INFO - 'HOME': '/home/cltbld', 11:59:36 INFO - 'LANG': 'en_US.UTF-8', 11:59:36 INFO - 'LANGUAGE': 'en_US:en', 11:59:36 INFO - 'LOGNAME': 'cltbld', 11:59:36 INFO - 'MAIL': '/var/mail/cltbld', 11:59:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:59:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:59:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:36 INFO - 'MOZ_NO_REMOTE': '1', 11:59:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:59:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:59:36 INFO - 'NO_EM_RESTART': '1', 11:59:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:59:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:36 INFO - 'PWD': '/builds/slave/test', 11:59:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:59:36 INFO - 'SHELL': '/bin/bash', 11:59:36 INFO - 'SHLVL': '1', 11:59:36 INFO - 'TERM': 'linux', 11:59:36 INFO - 'TMOUT': '86400', 11:59:36 INFO - 'USER': 'cltbld', 11:59:36 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461610254.908545-2104960304', 11:59:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:36 INFO - '_': '/tools/buildbot/bin/python'} 11:59:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FvDwgoaJSAKnQ9PG_3oVmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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:59:36 INFO - mozversion application_buildid: 20160425101116 11:59:36 INFO - mozversion application_changeset: 2045bc8c9e90a7ca0b8c6447ddecd812a71b29e1 11:59:36 INFO - mozversion application_display_name: Nightly 11:59:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:59:36 INFO - mozversion application_name: Firefox 11:59:36 INFO - mozversion application_remotingname: firefox 11:59:36 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:59:36 INFO - mozversion application_vendor: Mozilla 11:59:36 INFO - mozversion application_version: 49.0a1 11:59:36 INFO - mozversion platform_buildid: 20160425101116 11:59:36 INFO - mozversion platform_changeset: 2045bc8c9e90a7ca0b8c6447ddecd812a71b29e1 11:59:36 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:59:36 INFO - mozversion platform_version: 49.0a1 11:59:36 INFO - using testdate: 1461610776 11:59:36 INFO - actual date: 1461610776 11:59:36 INFO - starting webserver on 'localhost:50429' 11:59:36 INFO - SUITE-START | Running 2 tests 11:59:36 INFO - TEST-START | dromaeo_css 11:59:36 INFO - operating with platform_type : linux_ 11:59:36 INFO - Initialising browser for dromaeo_css test... 11:59:36 INFO - TEST-INFO | started process 10965 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUhdEeX/profile http://localhost:50429/getInfo.html) 11:59:41 INFO - PROCESS | 10965 | __metrics Screen width/height:1600/1200 11:59:41 INFO - PROCESS | 10965 | colorDepth:24 11:59:41 INFO - PROCESS | 10965 | Browser inner width/height: 1024/697 11:59:41 INFO - PROCESS | 10965 | __metrics 11:59:42 ERROR - PROCESS | 10965 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:59:43 INFO - TEST-INFO | 10965: exit 0 11:59:43 INFO - Browser initialized. 11:59:43 INFO - Running cycle 1/1 for dromaeo_css test... 11:59:43 INFO - TEST-INFO | started process 11050 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUhdEeX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:59:55 INFO - PROCESS | 11050 | RSS: Main: 156622848 11:59:55 INFO - PROCESS | 11050 | 12:00:46 INFO - PROCESS | 11050 | 1461610846636 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] 12:02:57 INFO - PROCESS | 11050 | Cycle 1(1): loaded http://localhost:50429/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50429/tests/dromaeo/cssquery-ext.html) 12:02:58 INFO - PROCESS | 11050 | RSS: Main: 228474880 12:02:58 INFO - PROCESS | 11050 | 12:06:01 INFO - PROCESS | 11050 | Cycle 1(1): loaded http://localhost:50429/tests/dromaeo/cssquery-ext.html (next: http://localhost:50429/tests/dromaeo/cssquery-jquery.html) 12:06:01 INFO - PROCESS | 11050 | RSS: Main: 236478464 12:06:01 INFO - PROCESS | 11050 | 12:09:04 INFO - PROCESS | 11050 | Cycle 1(1): loaded http://localhost:50429/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50429/tests/dromaeo/cssquery-mootools.html) 12:09:04 INFO - PROCESS | 11050 | RSS: Main: 241344512 12:09:04 INFO - PROCESS | 11050 | 12:12:06 INFO - PROCESS | 11050 | Cycle 1(1): loaded http://localhost:50429/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50429/tests/dromaeo/cssquery-prototype.html) 12:12:07 INFO - PROCESS | 11050 | RSS: Main: 232448000 12:12:07 INFO - PROCESS | 11050 | 12:15:10 INFO - PROCESS | 11050 | Cycle 1(1): loaded http://localhost:50429/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50429/tests/dromaeo/cssquery-yui.html) 12:15:11 INFO - PROCESS | 11050 | RSS: Main: 212426752 12:15:11 INFO - PROCESS | 11050 | 12:18:13 INFO - PROCESS | 11050 | Cycle 1(1): loaded http://localhost:50429/tests/dromaeo/cssquery-yui.html (next: http://localhost:50429/tests/dromaeo/cssquery-dojo.html) 12:18:14 INFO - PROCESS | 11050 | RSS: Main: 276844544 12:18:14 INFO - PROCESS | 11050 | 12:18:14 INFO - PROCESS | 11050 | __start_tp_report 12:18:14 INFO - PROCESS | 11050 | _x_x_mozilla_page_load 12:18:14 INFO - PROCESS | 11050 | _x_x_mozilla_page_load_details 12:18:14 INFO - PROCESS | 11050 | |i|pagename|runs| 12:18:14 INFO - PROCESS | 11050 | |0;dojo.html;2607.243899269212;2665.067226470737;2698.9339211011643;2707;2725.2233113562625;4606.654500912428;4652.837150699726;4686.71879687219;4707.90584188316;4722.220833562458;4683.086798074377;4720.716756994582;4753.714777113376;4759;4765.928511072337;4302.591253830881;4332.63172630326;4384.167008268419;4407.889802754925;4440.333949907524;4368.432103826514;4383.145286669101;4397.648188144956;4399.5820397062225;4456.19788438081;4267.295896177143;4298.290782020963;4338.609525142752;4343.717658352229;4394.1870753910625;4332.458442694663;4381.539938306496;4382.53983331752;4387.319965405335;4428.3800267962515;4285.807138678767;4296.291111966521;4316.158349121923;4317.287647538153;4343.174796788631;4503.324501324795;4577.9771101144615;4608.331791890158;4653.371794807726;4654.138984287883;5060.620453466005;5076.213186955991;5090.440051594322;5096.949030509684;5139.100657384943;5105.82129625465;5112.795488180468;5126.5898728101665;5139.794408223704;5170.586353091744;4646.024334889644;4660.580547750718;4661.09108723799;4715.104130215248;4722.905541889212;5110.080185566634;5125.718085505333;5128.025675121715;5131.897362052738;5134.512221338967;4857.684250523705;4934.8766280843265;4939.481354457802;4945.307656928033;4975.950240497621;5054.2671312660195;5074.644774865724;5096.337476128079;5141.5886729061585;5148.794048238028;5000.049990501793;5015.04714104319;5019.272205530251;5020.874478138003;5056.443791182967;4925.310456536088;5000.1749711297225;5001.149804533238;5011.248312753043;5022.698638081727;4241.703080784378;4256.404103425523;4270.658347332268;4294.398784170218;4313.956860431418;3734.1224812169116;3740.9625903741157;3743.2700623378178;3749.5500539934837;3776.8866933992026;4308.5045219799495;4367.563243675607;4414.381986521889;4416.271315232951;4439.378487011821;5099.209622508517;5103.2855400244;5106.897862042739;5111;5153.252778347119;4375.409319741858;4415.536368681306;4419.911601767946;4449.510553839075;4456.821727130943;4412.161689279027;4454.844080457233;4541.704789188692;4550.044490656999;4558.4529856416775;4817.494163112823;4837.540433658797;4840.830570930071;4858.3441235432765;4896.2410826321975;5118.667286626506;5127.87180320495;5127.948720512747;5128.410232823273;5133.1273683473155;4628.60656844172;4792.976035119802;4857.295692124693;4859.149648811514;4881.926771098365;4940.75296235194;4949.678270912379;4954.801807927786;4964.106460837084;5007.69953802773;4989.276554899447;5036.320096786887;5038.496150384932;5040.672356296829;5071.873203169803;4742.762861856824;4891.046245982142;4923.975380123076;4940.333055037524;4985.750712464434;4872.707637541759;4901.411830580353;4903.436104847846;4911.680740751983;4967.776450059684;4704.9529504704515;4815.711057336571;4825.6139508839915;4829.541193586604;4880.633952453652;4844.249141383091;4924.507549245047;4925.507449255046;4949.752512374439;4997.825076122318;4831.782569784298;4837.685550439211;4850.126977144007;4855.441624213261;4877.829275975324 12:18:14 INFO - PROCESS | 11050 | |1;ext.html;581.2153592649923;592.2596754057428;600.0938582740064;615.009834166991;626.3454689849107;26642.600360994602;27208.59187112195;27253.591196132023;27286.727132728665;33242;36698.08254793631;37325.81337093311;37397.43903841444;37426.251474970486;37542.249155016885;7784.571848548313;8022.438429309951;8037.27664510194;8041.597920104001;8043.39674524413;7829.217078292154;7975.7607271781935;7976.641051152712;7978.840423191533;7982.2017798220295;7953.4432589718745;8013.439059265854;8016.8396632067615;8023.638936247883;8024.799380015488;7913.129555748863;7967.96016019922;7987.520748755093;7988.760337189894;7992;7801.96099019507;7928.603569821544;7930.762077137638;7932.206779322021;7937.2459616336355;37977.81011094955;38361.42457863134;38500.61499384998;38507.614923850684;38608.22783544313;2867.655881294258;2978.940421191564;3044.923876903073;3070.370574032318;3148.244421338885;28333.71666283352;28855.711442885513;28965.855170724222;29026.41947161045;29945.251368715737;3389.8305084745666;3410.2667926395943;3411.675890790371;3442.242706604568;3442.6729460701445;185775;187832;189487;189532;200750;55032.724836375564;55830.72084639551;55841.72079139578;55870;55876;50519.24221136686;50793.238101428506;50814.74592627013;50875.7456212724;58165;14222.359993800304;14464.927675361767;14466.566003019927;14467.638309042148;14469.348879300456;10857.077148442471;10889.673309800719;10920.726981825517;10925.07136893373;10929.344239345506;18036.54908627295;18040.639187216184;18130;18196.63606727858;18211.72682409765;6744.460443164535;6954.200266969262;7101.183363913216;7148.892766608505;7192.892106618405;803.337246771416;829.1459796409707;899.8515244984635;934.1125930366179;976.7216343342113;27524.58713119305;28104;28155;28529.857350713115;28643;816.5223344343625;947.130195507613;948.2366694810605;980.1282243027996;1013.4122209118841;13390.330483475982;14174.433022678977;14182.645433864236;14224.573262801925;14266.572002839932;331262;331772;332259;333577;334586;48101;49089.827364674406;49257.50742492601;49283.50716492789;49312.50687493151;1002.7615894370447;1114.3258328711174;1155.9884401156048;1178.9818065751874;1206.1074804644675;27102.322441939108;29803.254918627208;29816.70183298139;30091.247718807204;30465.695343047173;42804.143917122106;43945.12109757723;44012.559874400846;44022.33966490441;44040.119197615226;295259;302275;305927.29254475987;306398;306803;28319.575206371508;28878.278043049093;29535.704642954155;29549;29609;38514;38692.6130738689;39114;39575.80212098921;39945.20109597734;35241.29517409586;36003;36061.91493919569;36869;36957;35251.47122793109;35420.46869297014;35441.645583544865;35692.28615427729;36230.637693622724;32608.184795379355;33328.166795829326;35776.46335305025;35842.462363064056;36359.636403635624;28746.281342966595;30632.234194145323;32612.34775304528;32619.18452038718;32801.179970500925;24158;24722.752772472046;24744.752552474245;25256.62115068312;25266.494670106862 12:18:14 INFO - PROCESS | 11050 | |2;jquery.html;373.1101323343825;377.59974427107267;377.86774628879897;379.571084674318;381.6755757606035;15792.921035394822;16337.918310408446;16671.83328166718;16685.165741712928;16707.248173832177;15649.921750391231;17070.317187312525;17363.87134836238;17383.304667813303;17395.130243487805;5035.647504674675;5278.261043453919;5304.92042619361;5310.15037593985;5317.308749862513;3690.9815450922843;3866.439366291886;5208.7395630218525;5778.971105144489;6084.939150608504;6001.879962400772;6012.18835457212;6034.125051867477;6034.818955431344;6046.12331211974;5879.441453061952;5957.225560677106;6026.4576188143055;6033.577649564532;6124.785632502841;3382.9323413531592;5101.821436249714;5333.120035194188;5342.439043900374;5380.757865896044;19142.23431062756;19511.219551217935;19525.80474195268;19549.902250488798;19590.118444670024;1774.591843875903;1863.80430054845;1902.4673091534391;2097.685347197917;2230.955380892373;12144.574939877062;12298.754024919452;12900.870991290061;13057.804132938014;13639.249841258727;1805.5756897129163;1805.8645601579933;1812.0667856054142;1868.4394681595468;1870.9906450467797;66170.3382966169;66662.33337666659;67254.3274567253;67626.9999999995;68938.3106168937;9410.247180225566;9417.717468475958;9579.664711735057;9707.320487565803;9847.310688251753;13239.27184004889;13412.396442160127;13414.396352164176;13415.060945733705;13439.395227214798;7079.964600176966;7102.467314951399;7150.678219480136;7226.963865180745;7270.454715896329;6799.626020568916;6802.897956530656;6819.181698196248;6949.061876646689;6952.061471701357;6039.486643635252;6072.119542666377;6139.96930015356;6204.7828326008375;6215;1658.3449537432646;1680.5042512458854;1691.4587332053625;1735.719490163592;1742.2595396956242;773.2499475508747;861.763015170833;930.5626355612851;948.7153853843819;1008.1581879131007;15568.844311556966;16456.506304810635;17005;17524.5618859527;17768.200430980378;852.6887685994567;883.5979629268668;890.5013192612158;922.3497434308796;923.810618823153;9850.556724947395;9884.209263258923;9970.351927124713;10192.592296308212;10230.437325946996;339712;352215;352891;353159;353719;43868.122637547705;67787.66106169537;69027;70348.6482567594;72897;858.0775666158779;945.546137853834;948.9952550237342;969.2343048991218;970.0784254957819;13722.862771372558;14485.927570362503;14511.274436278354;14569.781453277998;14920.925395372953;32663.510047348835;32711.345773084882;32825;32978.5053224197;33744.48149833214;40446.393304099875;40496.79751601223;40897.38653920253;41072.79463602782;41609.37585936153;7532.209118042527;7711.03612048494;7798.571078590732;7857.096433910174;8030.959845200737;11240.4379781009;11458.541658333907;11501.827472588086;11815.586454474053;11955.103367247317;9220.170184683411;9789.608415663293;10348.637797677045;10389.37663740178;10521.316114452537;10073.899261007296;10099.545520451744;10137.695869123938;10162;10535.63125290611;10283.845742313722;10502.737431564272;10579.576816927236;10663.840042399526;10886;7638.427117966064;7680.462367634212;7702.537847729154;7838.098618658927;7949.960250198712;10503;10650.414227217267;10686.198535110054;10780.29928054674;10881.238313317992 12:18:14 INFO - PROCESS | 11050 | |3;mootools.html;1236.320023986808;1379.413749156609;1418.6949805791753;1484.829244636867;1672.7490876368543;6606.438452731518;6934.653267336632;7132.429405647548;7151.106111736033;7154.320339567746;7041.8591628167405;7046.18968818586;7096.645167741618;7104.857902841953;7111.85776284474;1866.7479890214784;2156.385430152399;2159.8164156046755;2192.3094225319055;2193.1556350804976;2208.6024515587187;2236.13908645172;2236.7539570647214;2237.5636750833596;2239.2162743039967;2204.559088182362;2229.643257078868;2232.3079845247944;2235;2239.305815197286;1787.973180402295;2122.2253877334815;2141.4539292480395;2151.623465893478;2183.3995651195887;2165.945851353729;2170.6526955687173;2191.912323507074;2196.461866842618;2197.5934452126407;7102.644867756643;7156.391706704936;7158.248383919666;7183.676734546958;7191.35277824993;4279.914401711948;4374.4094547236355;4393.824247030147;4394.36281739146;4401.977990110061;2746.121241202816;2815.2539577011903;2918.9270268243463;2927.7804164687523;2945.190072729995;875.1554749666602;884.9646014159426;888.3870129610548;888.5779254853958;902.1384577728254;9609.279304052225;9637.807243855154;9661.855072173923;9662.275329350327;9676.371035882716;4020.6381425671243;4123.175364927027;4144;4196.643285320782;4224.176285624274;8256.504609723435;8258.174182581693;8273.875891861628;8280.254777070093;8286.751397458085;4359.651227901761;4421.226285400042;4425.867223983286;4434.866953991385;4442.400275962704;3649.6897763690386;3996.800159991989;4010.19796040793;4075.4294398784195;4114.0948991221885;3606.2967721294094;3650.1969566695284;3698.038509987369;3702.5927148013698;3779.3764028934916;1158.3802665573878;1158.559747296039;1183.248637115438;1183.6094088950626;1200.8138738495547;708.7909066825299;788.3377962511518;800.3877034068942;821.3306155483263;826.2192228344157;4699.741514216683;4834.274858771142;5107.693538387709;5202.3497062867145;5239.1093514102695;854.2269246332079;859.1408591408591;874.6807415293372;896.4397251717677;907.8275127725711;3081.938361232763;3281.261716113903;3293.6870997255223;3324.3185147044796;3381.0871064812854;8630.741077767678;8814.647414103363;8950.14973577509;9022.097790220925;9039.909600903908;8893.555322233991;8895.4662720237;8958.283337332998;8978.68574599899;8979.191872731355;6839.31606839322;6874;6877.724891004304;6984.755533556403;7000.194977577644;4669.906601868011;4709.48195698466;4713;4730.511851119501;4824.807007719652;8220.383471239562;8313.251807337369;8350.916490835014;8390.244877961013;8419.8737018946;8310.459820111673;8326.375521836007;8396.496210227406;8437.873431898404;8527.957360213408;5655.943440565707;6076.118962750288;6119.418655227746;6203.2556093269095;6272.905906411316;7302.087239095114;7321;7362.411007119525;7380.372668323253;7397.223291554525;6505.41451269388;6523.967380163069;6547.9672601638595;6573;6704.966475167593;6556.803295901131;6590.5716128451495;6627.237867645283;6636.5686230396805;6662.367075127855;5786.913196302143;5834.27071616048;5838.912416313674;5854.648721076749;5862.237909071793;4058.9594104058583;4323.567643235651;4341.15347507233;4383.473983122046;4414.6625964808545;4333.6998900329145;4368.148211098805;4385.407969924019;4405.82376704941;4439 12:18:14 INFO - PROCESS | 11050 | |4;prototype.html;294.7259049084352;309.49397734703757;310.2383648143807;312.8248181018631;313.61738678811855;4477.507474177846;4641.6054635355995;4651.88370290742;4722.291656251559;4731.763411829407;4466.285394336906;4562.931556026654;4605.516420775821;4632.49042605314;4653.69750966187;3703.259348130371;3713.3316003119426;3714.23858109087;3722.590515043343;3725.4039353703415;3516.226430185355;3533.240353324035;3711.109333759905;3713.2202237530014;3716.535433070866;3664.743467957244;3681.466187402825;3681.852725890961;3684.521012268401;3688.2992231475932;3643.653852883972;3652.3425783358985;3688.5020522229424;3691.50164727761;3695.946655203281;3249;3275.901722948315;3280.3767284215924;3293.9835300823343;3302.3230237801195;4254.446921900164;4465.307877279027;4493.191225579394;4516.322551617283;4555.63554915606;4099.97950010251;4118.629323360912;4126.00975765817;4134.37984302354;4141.461609990682;4884.5603895649565;4893.535114164149;4905.656604037718;4912.435069966964;4937.382827146606;3311.403947289487;3497.545319108525;3503.544539209912;3512.1570823002553;3542.167590616203;5044.319016932704;5115.590752739809;5120.207927225479;5122.974385128088;5126.179811230222;3569.3575156472084;3571.8212989713334;3575.6245594212755;3587.3004764070756;3609.296187243515;3643.890683279506;3647.3981793004386;3647.4893514907935;3657.5062366580173;3671.5227020487164;3903.4925459690626;4083.060895993938;4102.056526998807;4121.649659778953;4158.979205103955;4842.128416884924;4888.877778055577;4901.034873901239;4910.435299940481;4916.803327866845;1249.6063739921894;1264.62061381587;1313.317075120951;1324.2253281830237;1325.3704490367;855.7988872614931;876.4102078358436;876.5135349880877;876.9210771030511;878.4729162502575;4611.792469338888;4628.21813601759;4628.282616194495;4628.352030715702;4631.907361852744;5349;5355.946440535545;5360.758765855546;5366.517013468807;5380.488853558905;4505.954940450619;4599.356090147382;4609.193391156534;4622.6764126510825;4624.907501849944;2824.5057115004793;2838.7870909681856;2839.1908306132655;2844.7013063628433;2847.373577812878;5020.573251273682;5032.710116896803;5044.142495775727;5052.343195384577;5061.974690126526;5305.946940530623;5419.891602167934;5463.180522921593;5466.414739725515;5476.479734425223;5051.646384753032;5067.442581316052;5068.59451243907;5074.771635276422;5086.745662716849;5322.41453440129;5342.679439233659;5350.866228344323;5352;5353.437889021597;5037.798488060436;5229.241759944711;5233.319668443078;5235.554977826775;5236.188390799432;5033.421156567042;5063.367079115111;5066.923996139987;5067.366579177603;5067.5185857343495;3730.2539492101146;3730.3471892418174;3731.9067023324633;3734.719896007756;3742.7192960527523;4799.712017278975;5194.039102766001;5264.6314757966575;5349.893002140013;5369.5167434931045;4761.857144285677;4873.122837889214;4946.1591529439365;4946.925796113133;4959.578435832995;4733.3906471799755;4770.403699537558;4829.13075646387;4841.491643377535;4875.463698993037;4599.333096701027;4813.278008298643;4824.396950381202;4850.1269771441475;4859.392575928009;4929.482404347636;4959.776810043484;4969.428515720739;4980.950190498049;4984.302197692398;4842.903141937071;4850.563449289581;4865.759231395971;4881.341018962395;4886.65793394459 12:18:14 INFO - PROCESS | 11050 | |5;yui.html;616.8180386785895;620.4385031546451;629.3706293706293;690.9773535167951;738.1953670499156;10705.250632455722;11059.612913548008;11067.391293478855;11089.833652495208;11121.55513779448;10889.455527223627;10978.670639880796;10988.505517251742;11237.887621123786;11361.375124368156;813.3330668851559;815.7552734179752;820.5281962871343;820.6553247636007;822.2312138150818;648.7210499485219;785.2030189357778;808.7533302342783;811.2293321344716;812.7927378518469;849.6304107713133;850.2475309351238;850.4684572142411;851.4976164063202;851.8083431227986;847.9788005299886;848.9660413583449;849.379952634574;849.4393700157927;850.4259624753266;499.7501249375312;604.6795198544778;612.7518355066205;619.2166908860295;620.4385031546458;11367.147463940237;11421;11422.600208992728;11430.314181149075;11477;10760.40817755023;11301.943490282578;11544.480498377594;11676.416179191006;11836.526538938431;9587.424754514752;9652.276079294012;9684.661036863676;9918.603255869828;9998.900010999869;3139.8116113033293;3172.9682703172903;3202.1834432219866;3237.2068843133584;3280.343931213743;43981;44143.99999999968;44173.337399939024;44573.77713111446;44613.55386446127;9460.621575136918;9619.807603847883;9622.759431014141;9662.13040826329;9707.320487565943;15598.220088995506;15607.063576185237;15607.063576185465;15610.843891561166;15667.529974100795;6474.611523308617;6498;6515.213062130313;6518.1200537927725;6832.385085342343;3486.2330287336745;3587.192881601619;3639.763415377992;3687.465317528943;3704.240630670706;2762.778977681781;2785.3872148127784;2810.058630358812;2827.7313655203134;2830.6461692288462;491.7860730582137;497.4801332607434;501.77169387928404;501.9723915184627;504.25118698732354;475.3867510910955;509.8878246785701;519.291167556283;522.9712365819917;531.7580500872094;6964.721411143498;6976.441884649216;7031;7054.4003759681;7245.275472452712;431.9784010799447;459.25600527146236;466.5194849305221;492.30093267560153;564.2889958652046;3183.3951549205576;3229.870805167814;3279.4097062528494;3305.173706573357;3347.2301370684877;35670.10824729351;35822.462663060076;35956.64043359585;51396.74301628468;52472.47527524676;43749;45231.77384113058;45534.54465455303;45952.3107153393;47635.52364476311;39992.20015599672;40324.39513407301;41071.38392924168;42656;44183;7348.448866334939;7382.446316526175;7544.245575442412;7571.545707257582;7592.354649854824;27901.023464178656;28958.855205723838;29273.70726292795;29580;30030;35984;37907;38340.42489362606;38496.2300753989;38697.80651096727;9309.20871725911;9511.66709165176;9578.473183974947;9592.23262139041;9638.084381983701;10213.948930255598;10452.477376131315;10532.315399499008;10758.515866785858;10889.074428673652;8959;9182;9184.311176661911;9378.624855005723;9494.810103798023;9705.417674939526;9731.416115032838;9932.553035113293;10052.69841904744;10190.388576685422;9131.315151363542;9162.541872906462;9313.627454901729;9455.669051583161;9672.613095476103;8281.29608983219;8326.209010144026;8432.915670843213;8780.297576193761;8802.25180859634;8348.791280218044;8403.873941890753;8511.148885111686;8565.48607083577;8682.348823838363 12:18:14 INFO - PROCESS | 11050 | __end_tp_report 12:18:14 INFO - PROCESS | 11050 | __start_cc_report 12:18:14 INFO - PROCESS | 11050 | _x_x_mozilla_cycle_collect,1039 12:18:14 INFO - PROCESS | 11050 | __end_cc_report 12:18:14 INFO - PROCESS | 11050 | __startTimestamp1461611894003__endTimestamp 12:18:14 INFO - PROCESS | 11050 | 12:18:14 INFO - PROCESS | 11050 | ------- Summary: start ------- 12:18:14 INFO - PROCESS | 11050 | Number of tests: 6 12:18:14 INFO - PROCESS | 11050 | 12:18:14 INFO - PROCESS | 11050 | [#0] dojo.html Cycles:165 Average:4672.78 Median:4829.54 stddev:483.49 (10.0%) stddev-sans-first:457.02 12:18:14 INFO - PROCESS | 11050 | Values: 2607.2 2665.1 2698.9 2707.0 2725.2 4606.7 4652.8 4686.7 4707.9 4722.2 4683.1 4720.7 4753.7 4759.0 4765.9 4302.6 4332.6 4384.2 4407.9 4440.3 4368.4 4383.1 4397.6 4399.6 4456.2 4267.3 4298.3 4338.6 4343.7 4394.2 4332.5 4381.5 4382.5 4387.3 4428.4 4285.8 4296.3 4316.2 4317.3 4343.2 4503.3 4578.0 4608.3 4653.4 4654.1 5060.6 5076.2 5090.4 5096.9 5139.1 5105.8 5112.8 5126.6 5139.8 5170.6 4646.0 4660.6 4661.1 4715.1 4722.9 5110.1 5125.7 5128.0 5131.9 5134.5 4857.7 4934.9 4939.5 4945.3 4976.0 5054.3 5074.6 5096.3 5141.6 5148.8 5000.0 5015.0 5019.3 5020.9 5056.4 4925.3 5000.2 5001.1 5011.2 5022.7 4241.7 4256.4 4270.7 4294.4 4314.0 3734.1 3741.0 3743.3 3749.6 3776.9 4308.5 4367.6 4414.4 4416.3 4439.4 5099.2 5103.3 5106.9 5111.0 5153.3 4375.4 4415.5 4419.9 4449.5 4456.8 4412.2 4454.8 4541.7 4550.0 4558.5 4817.5 4837.5 4840.8 4858.3 4896.2 5118.7 5127.9 5127.9 5128.4 5133.1 4628.6 4793.0 4857.3 4859.1 4881.9 4940.8 4949.7 4954.8 4964.1 5007.7 4989.3 5036.3 5038.5 5040.7 5071.9 4742.8 4891.0 4924.0 4940.3 4985.8 4872.7 4901.4 4903.4 4911.7 4967.8 4705.0 4815.7 4825.6 4829.5 4880.6 4844.2 4924.5 4925.5 4949.8 4997.8 4831.8 4837.7 4850.1 4855.4 4877.8 12:18:14 INFO - PROCESS | 11050 | 12:18:14 INFO - PROCESS | 11050 | [#1] ext.html Cycles:180 Average:43435.68 Median:35431.06 stddev:74095.46 (209.1%) stddev-sans-first:74233.46 12:18:14 INFO - PROCESS | 11050 | Values: 581.2 592.3 600.1 615.0 626.3 26642.6 27208.6 27253.6 27286.7 33242.0 36698.1 37325.8 37397.4 37426.3 37542.2 7784.6 8022.4 8037.3 8041.6 8043.4 7829.2 7975.8 7976.6 7978.8 7982.2 7953.4 8013.4 8016.8 8023.6 8024.8 7913.1 7968.0 7987.5 7988.8 7992.0 7802.0 7928.6 7930.8 7932.2 7937.2 37977.8 38361.4 38500.6 38507.6 38608.2 2867.7 2978.9 3044.9 3070.4 3148.2 28333.7 28855.7 28965.9 29026.4 29945.3 3389.8 3410.3 3411.7 3442.2 3442.7 185775.0 187832.0 189487.0 189532.0 200750.0 55032.7 55830.7 55841.7 55870.0 55876.0 50519.2 50793.2 50814.7 50875.7 58165.0 14222.4 14464.9 14466.6 14467.6 14469.3 10857.1 10889.7 10920.7 10925.1 10929.3 18036.5 18040.6 18130.0 18196.6 18211.7 6744.5 6954.2 7101.2 7148.9 7192.9 803.3 829.1 899.9 934.1 976.7 27524.6 28104.0 28155.0 28529.9 28643.0 816.5 947.1 948.2 980.1 1013.4 13390.3 14174.4 14182.6 14224.6 14266.6 331262.0 331772.0 332259.0 333577.0 334586.0 48101.0 49089.8 49257.5 49283.5 49312.5 1002.8 1114.3 1156.0 1179.0 1206.1 27102.3 29803.3 29816.7 30091.2 30465.7 42804.1 43945.1 44012.6 44022.3 44040.1 295259.0 302275.0 305927.3 306398.0 306803.0 28319.6 28878.3 29535.7 29549.0 29609.0 38514.0 38692.6 39114.0 39575.8 39945.2 35241.3 36003.0 36061.9 36869.0 36957.0 35251.5 35420.5 35441.6 35692.3 36230.6 32608.2 33328.2 35776.5 35842.5 36359.6 28746.3 30632.2 32612.3 32619.2 32801.2 24158.0 24722.8 24744.8 25256.6 25266.5 12:18:14 INFO - PROCESS | 11050 | 12:18:14 INFO - PROCESS | 11050 | [#2] jquery.html Cycles:180 Average:22525.57 Median:378.72 stddev:57668.52 (15227.2%) stddev-sans-first:57806.31 12:18:14 INFO - PROCESS | 11050 | Values: 373.1 377.6 377.9 379.6 381.7 15792.9 16337.9 16671.8 16685.2 16707.2 15649.9 17070.3 17363.9 17383.3 17395.1 5035.6 5278.3 5304.9 5310.2 5317.3 3691.0 3866.4 5208.7 5779.0 6084.9 6001.9 6012.2 6034.1 6034.8 6046.1 5879.4 5957.2 6026.5 6033.6 6124.8 3382.9 5101.8 5333.1 5342.4 5380.8 19142.2 19511.2 19525.8 19549.9 19590.1 1774.6 1863.8 1902.5 2097.7 2231.0 12144.6 12298.8 12900.9 13057.8 13639.2 1805.6 1805.9 1812.1 1868.4 1871.0 66170.3 66662.3 67254.3 67627.0 68938.3 9410.2 9417.7 9579.7 9707.3 9847.3 13239.3 13412.4 13414.4 13415.1 13439.4 7080.0 7102.5 7150.7 7227.0 7270.5 6799.6 6802.9 6819.2 6949.1 6952.1 6039.5 6072.1 6140.0 6204.8 6215.0 1658.3 1680.5 1691.5 1735.7 1742.3 773.2 861.8 930.6 948.7 1008.2 15568.8 16456.5 17005.0 17524.6 17768.2 852.7 883.6 890.5 922.3 923.8 9850.6 9884.2 9970.4 10192.6 10230.4 339712.0 352215.0 352891.0 353159.0 353719.0 43868.1 67787.7 69027.0 70348.6 72897.0 858.1 945.5 949.0 969.2 970.1 13722.9 14485.9 14511.3 14569.8 14920.9 32663.5 32711.3 32825.0 32978.5 33744.5 40446.4 40496.8 40897.4 41072.8 41609.4 7532.2 7711.0 7798.6 7857.1 8031.0 11240.4 11458.5 11501.8 11815.6 11955.1 9220.2 9789.6 10348.6 10389.4 10521.3 10073.9 10099.5 10137.7 10162.0 10535.6 10283.8 10502.7 10579.6 10663.8 10886.0 7638.4 7680.5 7702.5 7838.1 7950.0 10503.0 10650.4 10686.2 10780.3 10881.2 12:18:14 INFO - PROCESS | 11050 | 12:18:14 INFO - PROCESS | 11050 | [#3] mootools.html Cycles:180 Average:4840.31 Median:5721.43 stddev:2621.23 (45.8%) stddev-sans-first:2614.59 12:18:14 INFO - PROCESS | 11050 | Values: 1236.3 1379.4 1418.7 1484.8 1672.7 6606.4 6934.7 7132.4 7151.1 7154.3 7041.9 7046.2 7096.6 7104.9 7111.9 1866.7 2156.4 2159.8 2192.3 2193.2 2208.6 2236.1 2236.8 2237.6 2239.2 2204.6 2229.6 2232.3 2235.0 2239.3 1788.0 2122.2 2141.5 2151.6 2183.4 2165.9 2170.7 2191.9 2196.5 2197.6 7102.6 7156.4 7158.2 7183.7 7191.4 4279.9 4374.4 4393.8 4394.4 4402.0 2746.1 2815.3 2918.9 2927.8 2945.2 875.2 885.0 888.4 888.6 902.1 9609.3 9637.8 9661.9 9662.3 9676.4 4020.6 4123.2 4144.0 4196.6 4224.2 8256.5 8258.2 8273.9 8280.3 8286.8 4359.7 4421.2 4425.9 4434.9 4442.4 3649.7 3996.8 4010.2 4075.4 4114.1 3606.3 3650.2 3698.0 3702.6 3779.4 1158.4 1158.6 1183.2 1183.6 1200.8 708.8 788.3 800.4 821.3 826.2 4699.7 4834.3 5107.7 5202.3 5239.1 854.2 859.1 874.7 896.4 907.8 3081.9 3281.3 3293.7 3324.3 3381.1 8630.7 8814.6 8950.1 9022.1 9039.9 8893.6 8895.5 8958.3 8978.7 8979.2 6839.3 6874.0 6877.7 6984.8 7000.2 4669.9 4709.5 4713.0 4730.5 4824.8 8220.4 8313.3 8350.9 8390.2 8419.9 8310.5 8326.4 8396.5 8437.9 8528.0 5655.9 6076.1 6119.4 6203.3 6272.9 7302.1 7321.0 7362.4 7380.4 7397.2 6505.4 6524.0 6548.0 6573.0 6705.0 6556.8 6590.6 6627.2 6636.6 6662.4 5786.9 5834.3 5838.9 5854.6 5862.2 4059.0 4323.6 4341.2 4383.5 4414.7 4333.7 4368.1 4385.4 4405.8 4439.0 12:18:14 INFO - PROCESS | 11050 | 12:18:14 INFO - PROCESS | 11050 | [#4] prototype.html Cycles:180 Average:4160.46 Median:4637.05 stddev:1217.81 (26.3%) stddev-sans-first:1186.16 12:18:14 INFO - PROCESS | 11050 | Values: 294.7 309.5 310.2 312.8 313.6 4477.5 4641.6 4651.9 4722.3 4731.8 4466.3 4562.9 4605.5 4632.5 4653.7 3703.3 3713.3 3714.2 3722.6 3725.4 3516.2 3533.2 3711.1 3713.2 3716.5 3664.7 3681.5 3681.9 3684.5 3688.3 3643.7 3652.3 3688.5 3691.5 3695.9 3249.0 3275.9 3280.4 3294.0 3302.3 4254.4 4465.3 4493.2 4516.3 4555.6 4100.0 4118.6 4126.0 4134.4 4141.5 4884.6 4893.5 4905.7 4912.4 4937.4 3311.4 3497.5 3503.5 3512.2 3542.2 5044.3 5115.6 5120.2 5123.0 5126.2 3569.4 3571.8 3575.6 3587.3 3609.3 3643.9 3647.4 3647.5 3657.5 3671.5 3903.5 4083.1 4102.1 4121.6 4159.0 4842.1 4888.9 4901.0 4910.4 4916.8 1249.6 1264.6 1313.3 1324.2 1325.4 855.8 876.4 876.5 876.9 878.5 4611.8 4628.2 4628.3 4628.4 4631.9 5349.0 5355.9 5360.8 5366.5 5380.5 4506.0 4599.4 4609.2 4622.7 4624.9 2824.5 2838.8 2839.2 2844.7 2847.4 5020.6 5032.7 5044.1 5052.3 5062.0 5305.9 5419.9 5463.2 5466.4 5476.5 5051.6 5067.4 5068.6 5074.8 5086.7 5322.4 5342.7 5350.9 5352.0 5353.4 5037.8 5229.2 5233.3 5235.6 5236.2 5033.4 5063.4 5066.9 5067.4 5067.5 3730.3 3730.3 3731.9 3734.7 3742.7 4799.7 5194.0 5264.6 5349.9 5369.5 4761.9 4873.1 4946.2 4946.9 4959.6 4733.4 4770.4 4829.1 4841.5 4875.5 4599.3 4813.3 4824.4 4850.1 4859.4 4929.5 4959.8 4969.4 4981.0 4984.3 4842.9 4850.6 4865.8 4881.3 4886.7 12:18:14 INFO - PROCESS | 11050 | 12:18:14 INFO - PROCESS | 11050 | [#5] yui.html Cycles:180 Average:11846.86 Median:507.07 stddev:13594.04 (2680.9%) stddev-sans-first:13606.02 12:18:14 INFO - PROCESS | 11050 | Values: 616.8 620.4 629.4 691.0 738.2 10705.3 11059.6 11067.4 11089.8 11121.6 10889.5 10978.7 10988.5 11237.9 11361.4 813.3 815.8 820.5 820.7 822.2 648.7 785.2 808.8 811.2 812.8 849.6 850.2 850.5 851.5 851.8 848.0 849.0 849.4 849.4 850.4 499.8 604.7 612.8 619.2 620.4 11367.1 11421.0 11422.6 11430.3 11477.0 10760.4 11301.9 11544.5 11676.4 11836.5 9587.4 9652.3 9684.7 9918.6 9998.9 3139.8 3173.0 3202.2 3237.2 3280.3 43981.0 44144.0 44173.3 44573.8 44613.6 9460.6 9619.8 9622.8 9662.1 9707.3 15598.2 15607.1 15607.1 15610.8 15667.5 6474.6 6498.0 6515.2 6518.1 6832.4 3486.2 3587.2 3639.8 3687.5 3704.2 2762.8 2785.4 2810.1 2827.7 2830.6 491.8 497.5 501.8 502.0 504.3 475.4 509.9 519.3 523.0 531.8 6964.7 6976.4 7031.0 7054.4 7245.3 432.0 459.3 466.5 492.3 564.3 3183.4 3229.9 3279.4 3305.2 3347.2 35670.1 35822.5 35956.6 51396.7 52472.5 43749.0 45231.8 45534.5 45952.3 47635.5 39992.2 40324.4 41071.4 42656.0 44183.0 7348.4 7382.4 7544.2 7571.5 7592.4 27901.0 28958.9 29273.7 29580.0 30030.0 35984.0 37907.0 38340.4 38496.2 38697.8 9309.2 9511.7 9578.5 9592.2 9638.1 10213.9 10452.5 10532.3 10758.5 10889.1 8959.0 9182.0 9184.3 9378.6 9494.8 9705.4 9731.4 9932.6 10052.7 10190.4 9131.3 9162.5 9313.6 9455.7 9672.6 8281.3 8326.2 8432.9 8780.3 8802.3 8348.8 8403.9 8511.1 8565.5 8682.3 12:18:14 INFO - PROCESS | 11050 | -------- Summary: end -------- 12:18:14 INFO - PROCESS | 11050 | 12:18:14 INFO - TEST-INFO | 11050: exit 0 12:18:14 INFO - TEST-OK | dromaeo_css | took 1117934ms 12:18:14 INFO - TEST-START | kraken 12:18:14 INFO - operating with platform_type : linux_ 12:18:14 INFO - Initialising browser for kraken test... 12:18:14 INFO - TEST-INFO | started process 11226 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOVy9IK/profile http://localhost:50429/getInfo.html) 12:18:18 INFO - PROCESS | 11226 | __metrics Screen width/height:1600/1200 12:18:18 INFO - PROCESS | 11226 | colorDepth:24 12:18:18 INFO - PROCESS | 11226 | Browser inner width/height: 1024/697 12:18:18 INFO - PROCESS | 11226 | __metrics 12:18:19 ERROR - PROCESS | 11226 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:18:20 INFO - TEST-INFO | 11226: exit 0 12:18:20 INFO - Browser initialized. 12:18:20 INFO - Running cycle 1/1 for kraken test... 12:18:20 INFO - TEST-INFO | started process 11306 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOVy9IK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:18:32 INFO - PROCESS | 11306 | RSS: Main: 155910144 12:18:32 INFO - PROCESS | 11306 | 12:18:35 INFO - PROCESS | 11306 | Cycle 1(1): loaded http://localhost:50429/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50429/tests/kraken/driver.html?testName=audio-beat-detection) 12:18:36 INFO - PROCESS | 11306 | RSS: Main: 211427328 12:18:36 INFO - PROCESS | 11306 | 12:18:38 INFO - PROCESS | 11306 | Cycle 1(1): loaded http://localhost:50429/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50429/tests/kraken/driver.html?testName=audio-dft) 12:18:39 INFO - PROCESS | 11306 | RSS: Main: 196386816 12:18:39 INFO - PROCESS | 11306 | 12:18:42 INFO - PROCESS | 11306 | Cycle 1(1): loaded http://localhost:50429/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50429/tests/kraken/driver.html?testName=audio-fft) 12:18:43 INFO - PROCESS | 11306 | RSS: Main: 266481664 12:18:43 INFO - PROCESS | 11306 | 12:18:45 INFO - PROCESS | 11306 | Cycle 1(1): loaded http://localhost:50429/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50429/tests/kraken/driver.html?testName=audio-oscillator) 12:18:46 INFO - PROCESS | 11306 | RSS: Main: 174575616 12:18:46 INFO - PROCESS | 11306 | 12:18:48 INFO - PROCESS | 11306 | Cycle 1(1): loaded http://localhost:50429/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50429/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:18:48 INFO - PROCESS | 11306 | RSS: Main: 179625984 12:18:48 INFO - PROCESS | 11306 | 12:18:52 INFO - PROCESS | 11306 | Cycle 1(1): loaded http://localhost:50429/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50429/tests/kraken/driver.html?testName=imaging-darkroom) 12:18:52 INFO - PROCESS | 11306 | RSS: Main: 216051712 12:18:52 INFO - PROCESS | 11306 | 12:18:56 INFO - PROCESS | 11306 | Cycle 1(1): loaded http://localhost:50429/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50429/tests/kraken/driver.html?testName=imaging-desaturate) 12:18:56 INFO - PROCESS | 11306 | RSS: Main: 213852160 12:18:56 INFO - PROCESS | 11306 | 12:18:59 INFO - PROCESS | 11306 | Cycle 1(1): loaded http://localhost:50429/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50429/tests/kraken/driver.html?testName=json-parse-financial) 12:19:00 INFO - PROCESS | 11306 | RSS: Main: 215261184 12:19:00 INFO - PROCESS | 11306 | 12:19:01 INFO - PROCESS | 11306 | Cycle 1(1): loaded http://localhost:50429/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50429/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:19:02 INFO - PROCESS | 11306 | RSS: Main: 202489856 12:19:02 INFO - PROCESS | 11306 | 12:19:04 INFO - PROCESS | 11306 | Cycle 1(1): loaded http://localhost:50429/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50429/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:19:05 INFO - PROCESS | 11306 | RSS: Main: 203911168 12:19:05 INFO - PROCESS | 11306 | 12:19:07 INFO - PROCESS | 11306 | Cycle 1(1): loaded http://localhost:50429/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50429/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:19:07 INFO - PROCESS | 11306 | RSS: Main: 216551424 12:19:07 INFO - PROCESS | 11306 | 12:19:10 INFO - PROCESS | 11306 | Cycle 1(1): loaded http://localhost:50429/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50429/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:19:11 INFO - PROCESS | 11306 | RSS: Main: 225632256 12:19:11 INFO - PROCESS | 11306 | 12:19:14 INFO - PROCESS | 11306 | Cycle 1(1): loaded http://localhost:50429/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50429/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:19:14 INFO - PROCESS | 11306 | RSS: Main: 222494720 12:19:14 INFO - PROCESS | 11306 | 12:19:16 INFO - PROCESS | 11306 | Cycle 1(1): loaded http://localhost:50429/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50429/tests/kraken/driver.html?testName=ai-astar) 12:19:16 INFO - PROCESS | 11306 | RSS: Main: 286842880 12:19:16 INFO - PROCESS | 11306 | 12:19:16 INFO - PROCESS | 11306 | __start_tp_report 12:19:16 INFO - PROCESS | 11306 | _x_x_mozilla_page_load 12:19:16 INFO - PROCESS | 11306 | _x_x_mozilla_page_load_details 12:19:16 INFO - PROCESS | 11306 | |i|pagename|runs| 12:19:16 INFO - PROCESS | 11306 | |0;ai-astar;113;114;109;113;115;115;103;117;114;113 12:19:16 INFO - PROCESS | 11306 | |1;audio-beat-detection;159;132;156;194;132;165;157;140;199;134 12:19:16 INFO - PROCESS | 11306 | |2;audio-dft;161;161;160;161;162;162;161;165;161;162 12:19:16 INFO - PROCESS | 11306 | |3;audio-fft;74;74;124;118;74;73;78;115;103;77 12:19:16 INFO - PROCESS | 11306 | |4;audio-oscillator;94;95;146;94;94;95;141;93;93;137 12:19:16 INFO - PROCESS | 11306 | |5;imaging-gaussian-blur;118;117;116;118;116;116;116;116;117;117 12:19:16 INFO - PROCESS | 11306 | |6;imaging-darkroom;147;146;146;146;147;147;147;146;147;146 12:19:16 INFO - PROCESS | 11306 | |7;imaging-desaturate;95;95;95;95;95;95;95;94;94;94 12:19:16 INFO - PROCESS | 11306 | |8;json-parse-financial;67;68;69;68;67;68;78;85;67;64 12:19:16 INFO - PROCESS | 11306 | |9;json-stringify-tinderbox;63;64;64;64;64;64;64;64;63;64 12:19:16 INFO - PROCESS | 11306 | |10;stanford-crypto-aes;79;79;78;78;80;79;80;80;86;80 12:19:16 INFO - PROCESS | 11306 | |11;stanford-crypto-ccm;138;132;133;126;131;133;128;136;167;129 12:19:16 INFO - PROCESS | 11306 | |12;stanford-crypto-pbkdf2;179;171;173;174;173;176;185;182;171;172 12:19:16 INFO - PROCESS | 11306 | |13;stanford-crypto-sha256-iterative;73;78;73;73;75;77;75;72;72;70 12:19:16 INFO - PROCESS | 11306 | __end_tp_report 12:19:16 INFO - PROCESS | 11306 | __start_cc_report 12:19:16 INFO - PROCESS | 11306 | _x_x_mozilla_cycle_collect,1873 12:19:16 INFO - PROCESS | 11306 | __end_cc_report 12:19:16 INFO - PROCESS | 11306 | __startTimestamp1461611956793__endTimestamp 12:19:16 INFO - PROCESS | 11306 | 12:19:16 INFO - PROCESS | 11306 | ------- Summary: start ------- 12:19:16 INFO - PROCESS | 11306 | Number of tests: 14 12:19:16 INFO - PROCESS | 11306 | 12:19:16 INFO - PROCESS | 11306 | [#0] ai-astar Cycles:10 Average:112.60 Median:114.00 stddev:3.95 (3.5%) stddev-sans-first:4.19 12:19:16 INFO - PROCESS | 11306 | Values: 113.0 114.0 109.0 113.0 115.0 115.0 103.0 117.0 114.0 113.0 12:19:16 INFO - PROCESS | 11306 | 12:19:16 INFO - PROCESS | 11306 | [#1] audio-beat-detection Cycles:10 Average:156.80 Median:158.00 stddev:24.20 (15.3%) stddev-sans-first:25.65 12:19:16 INFO - PROCESS | 11306 | Values: 159.0 132.0 156.0 194.0 132.0 165.0 157.0 140.0 199.0 134.0 12:19:16 INFO - PROCESS | 11306 | 12:19:16 INFO - PROCESS | 11306 | [#2] audio-dft Cycles:10 Average:161.60 Median:161.50 stddev:1.35 (0.8%) stddev-sans-first:1.41 12:19:16 INFO - PROCESS | 11306 | Values: 161.0 161.0 160.0 161.0 162.0 162.0 161.0 165.0 161.0 162.0 12:19:16 INFO - PROCESS | 11306 | 12:19:16 INFO - PROCESS | 11306 | [#3] audio-fft Cycles:10 Average:91.00 Median:74.00 stddev:21.33 (28.8%) stddev-sans-first:21.72 12:19:16 INFO - PROCESS | 11306 | Values: 74.0 74.0 124.0 118.0 74.0 73.0 78.0 115.0 103.0 77.0 12:19:16 INFO - PROCESS | 11306 | 12:19:16 INFO - PROCESS | 11306 | [#4] audio-oscillator Cycles:10 Average:108.20 Median:94.00 stddev:22.97 (24.4%) stddev-sans-first:23.78 12:19:16 INFO - PROCESS | 11306 | Values: 94.0 95.0 146.0 94.0 94.0 95.0 141.0 93.0 93.0 137.0 12:19:16 INFO - PROCESS | 11306 | 12:19:16 INFO - PROCESS | 11306 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.82 (0.7%) stddev-sans-first:0.73 12:19:16 INFO - PROCESS | 11306 | Values: 118.0 117.0 116.0 118.0 116.0 116.0 116.0 116.0 117.0 117.0 12:19:16 INFO - PROCESS | 11306 | 12:19:16 INFO - PROCESS | 11306 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 12:19:16 INFO - PROCESS | 11306 | Values: 147.0 146.0 146.0 146.0 147.0 147.0 147.0 146.0 147.0 146.0 12:19:16 INFO - PROCESS | 11306 | 12:19:16 INFO - PROCESS | 11306 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 12:19:16 INFO - PROCESS | 11306 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 94.0 94.0 12:19:16 INFO - PROCESS | 11306 | 12:19:16 INFO - PROCESS | 11306 | [#8] json-parse-financial Cycles:10 Average:70.10 Median:68.00 stddev:6.37 (9.4%) stddev-sans-first:6.65 12:19:16 INFO - PROCESS | 11306 | Values: 67.0 68.0 69.0 68.0 67.0 68.0 78.0 85.0 67.0 64.0 12:19:16 INFO - PROCESS | 11306 | 12:19:16 INFO - PROCESS | 11306 | [#9] json-stringify-tinderbox Cycles:10 Average:63.80 Median:64.00 stddev:0.42 (0.7%) stddev-sans-first:0.33 12:19:16 INFO - PROCESS | 11306 | Values: 63.0 64.0 64.0 64.0 64.0 64.0 64.0 64.0 63.0 64.0 12:19:16 INFO - PROCESS | 11306 | 12:19:16 INFO - PROCESS | 11306 | [#10] stanford-crypto-aes Cycles:10 Average:79.90 Median:80.00 stddev:2.28 (2.9%) stddev-sans-first:2.40 12:19:16 INFO - PROCESS | 11306 | Values: 79.0 79.0 78.0 78.0 80.0 79.0 80.0 80.0 86.0 80.0 12:19:16 INFO - PROCESS | 11306 | 12:19:16 INFO - PROCESS | 11306 | [#11] stanford-crypto-ccm Cycles:10 Average:135.30 Median:133.00 stddev:11.70 (8.8%) stddev-sans-first:12.37 12:19:16 INFO - PROCESS | 11306 | Values: 138.0 132.0 133.0 126.0 131.0 133.0 128.0 136.0 167.0 129.0 12:19:16 INFO - PROCESS | 11306 | 12:19:16 INFO - PROCESS | 11306 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.60 Median:175.00 stddev:4.86 (2.8%) stddev-sans-first:4.99 12:19:16 INFO - PROCESS | 11306 | Values: 179.0 171.0 173.0 174.0 173.0 176.0 185.0 182.0 171.0 172.0 12:19:16 INFO - PROCESS | 11306 | 12:19:16 INFO - PROCESS | 11306 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.80 Median:74.00 stddev:2.44 (3.3%) stddev-sans-first:2.57 12:19:16 INFO - PROCESS | 11306 | Values: 73.0 78.0 73.0 73.0 75.0 77.0 75.0 72.0 72.0 70.0 12:19:16 INFO - PROCESS | 11306 | -------- Summary: end -------- 12:19:16 INFO - PROCESS | 11306 | 12:19:17 INFO - TEST-INFO | 11306: exit 0 12:19:17 INFO - TEST-OK | kraken | took 63085ms 12:19:17 INFO - SUITE-END | took 1181s 12:19:17 INFO - Completed test suite (00:19:41) 12:19:17 INFO - javascript benchmark 12:19:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2607.243899269212, 2665.067226470737, 2698.9339211011643, 2707.0, 2725.2233113562625, 4606.654500912428, 4652.837150699726, 4686.71879687219, 4707.90584188316, 4722.220833562458, 4683.086798074377, 4720.716756994582, 4753.714777113376, 4759.0, 4765.928511072337, 4302.591253830881, 4332.63172630326, 4384.167008268419, 4407.889802754925, 4440.333949907524, 4368.432103826514, 4383.145286669101, 4397.648188144956, 4399.5820397062225, 4456.19788438081, 4267.295896177143, 4298.290782020963, 4338.609525142752, 4343.717658352229, 4394.1870753910625, 4332.458442694663, 4381.539938306496, 4382.53983331752, 4387.319965405335, 4428.3800267962515, 4285.807138678767, 4296.291111966521, 4316.158349121923, 4317.287647538153, 4343.174796788631, 4503.324501324795, 4577.9771101144615, 4608.331791890158, 4653.371794807726, 4654.138984287883, 5060.620453466005, 5076.213186955991, 5090.440051594322, 5096.949030509684, 5139.100657384943, 5105.82129625465, 5112.795488180468, 5126.5898728101665, 5139.794408223704, 5170.586353091744, 4646.024334889644, 4660.580547750718, 4661.09108723799, 4715.104130215248, 4722.905541889212, 5110.080185566634, 5125.718085505333, 5128.025675121715, 5131.897362052738, 5134.512221338967, 4857.684250523705, 4934.8766280843265, 4939.481354457802, 4945.307656928033, 4975.950240497621, 5054.2671312660195, 5074.644774865724, 5096.337476128079, 5141.5886729061585, 5148.794048238028, 5000.049990501793, 5015.04714104319, 5019.272205530251, 5020.874478138003, 5056.443791182967, 4925.310456536088, 5000.1749711297225, 5001.149804533238, 5011.248312753043, 5022.698638081727, 4241.703080784378, 4256.404103425523, 4270.658347332268, 4294.398784170218, 4313.956860431418, 3734.1224812169116, 3740.9625903741157, 3743.2700623378178, 3749.5500539934837, 3776.8866933992026, 4308.5045219799495, 4367.563243675607, 4414.381986521889, 4416.271315232951, 4439.378487011821, 5099.209622508517, 5103.2855400244, 5106.897862042739, 5111.0, 5153.252778347119, 4375.409319741858, 4415.536368681306, 4419.911601767946, 4449.510553839075, 4456.821727130943, 4412.161689279027, 4454.844080457233, 4541.704789188692, 4550.044490656999, 4558.4529856416775, 4817.494163112823, 4837.540433658797, 4840.830570930071, 4858.3441235432765, 4896.2410826321975, 5118.667286626506, 5127.87180320495, 5127.948720512747, 5128.410232823273, 5133.1273683473155, 4628.60656844172, 4792.976035119802, 4857.295692124693, 4859.149648811514, 4881.926771098365, 4940.75296235194, 4949.678270912379, 4954.801807927786, 4964.106460837084, 5007.69953802773, 4989.276554899447, 5036.320096786887, 5038.496150384932, 5040.672356296829, 5071.873203169803, 4742.762861856824, 4891.046245982142, 4923.975380123076, 4940.333055037524, 4985.750712464434, 4872.707637541759, 4901.411830580353, 4903.436104847846, 4911.680740751983, 4967.776450059684, 4704.9529504704515, 4815.711057336571, 4825.6139508839915, 4829.541193586604, 4880.633952453652, 4844.249141383091, 4924.507549245047, 4925.507449255046, 4949.752512374439, 4997.825076122318, 4831.782569784298, 4837.685550439211, 4850.126977144007, 4855.441624213261, 4877.829275975324], "value": 4642.516135391016, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.2153592649923, 592.2596754057428, 600.0938582740064, 615.009834166991, 626.3454689849107, 26642.600360994602, 27208.59187112195, 27253.591196132023, 27286.727132728665, 33242.0, 36698.08254793631, 37325.81337093311, 37397.43903841444, 37426.251474970486, 37542.249155016885, 7784.571848548313, 8022.438429309951, 8037.27664510194, 8041.597920104001, 8043.39674524413, 7829.217078292154, 7975.7607271781935, 7976.641051152712, 7978.840423191533, 7982.2017798220295, 7953.4432589718745, 8013.439059265854, 8016.8396632067615, 8023.638936247883, 8024.799380015488, 7913.129555748863, 7967.96016019922, 7987.520748755093, 7988.760337189894, 7992.0, 7801.96099019507, 7928.603569821544, 7930.762077137638, 7932.206779322021, 7937.2459616336355, 37977.81011094955, 38361.42457863134, 38500.61499384998, 38507.614923850684, 38608.22783544313, 2867.655881294258, 2978.940421191564, 3044.923876903073, 3070.370574032318, 3148.244421338885, 28333.71666283352, 28855.711442885513, 28965.855170724222, 29026.41947161045, 29945.251368715737, 3389.8305084745666, 3410.2667926395943, 3411.675890790371, 3442.242706604568, 3442.6729460701445, 185775.0, 187832.0, 189487.0, 189532.0, 200750.0, 55032.724836375564, 55830.72084639551, 55841.72079139578, 55870.0, 55876.0, 50519.24221136686, 50793.238101428506, 50814.74592627013, 50875.7456212724, 58165.0, 14222.359993800304, 14464.927675361767, 14466.566003019927, 14467.638309042148, 14469.348879300456, 10857.077148442471, 10889.673309800719, 10920.726981825517, 10925.07136893373, 10929.344239345506, 18036.54908627295, 18040.639187216184, 18130.0, 18196.63606727858, 18211.72682409765, 6744.460443164535, 6954.200266969262, 7101.183363913216, 7148.892766608505, 7192.892106618405, 803.337246771416, 829.1459796409707, 899.8515244984635, 934.1125930366179, 976.7216343342113, 27524.58713119305, 28104.0, 28155.0, 28529.857350713115, 28643.0, 816.5223344343625, 947.130195507613, 948.2366694810605, 980.1282243027996, 1013.4122209118841, 13390.330483475982, 14174.433022678977, 14182.645433864236, 14224.573262801925, 14266.572002839932, 331262.0, 331772.0, 332259.0, 333577.0, 334586.0, 48101.0, 49089.827364674406, 49257.50742492601, 49283.50716492789, 49312.50687493151, 1002.7615894370447, 1114.3258328711174, 1155.9884401156048, 1178.9818065751874, 1206.1074804644675, 27102.322441939108, 29803.254918627208, 29816.70183298139, 30091.247718807204, 30465.695343047173, 42804.143917122106, 43945.12109757723, 44012.559874400846, 44022.33966490441, 44040.119197615226, 295259.0, 302275.0, 305927.29254475987, 306398.0, 306803.0, 28319.575206371508, 28878.278043049093, 29535.704642954155, 29549.0, 29609.0, 38514.0, 38692.6130738689, 39114.0, 39575.80212098921, 39945.20109597734, 35241.29517409586, 36003.0, 36061.91493919569, 36869.0, 36957.0, 35251.47122793109, 35420.46869297014, 35441.645583544865, 35692.28615427729, 36230.637693622724, 32608.184795379355, 33328.166795829326, 35776.46335305025, 35842.462363064056, 36359.636403635624, 28746.281342966595, 30632.234194145323, 32612.34775304528, 32619.18452038718, 32801.179970500925, 24158.0, 24722.752772472046, 24744.752552474245, 25256.62115068312, 25266.494670106862], "value": 17112.897826005694, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.1101323343825, 377.59974427107267, 377.86774628879897, 379.571084674318, 381.6755757606035, 15792.921035394822, 16337.918310408446, 16671.83328166718, 16685.165741712928, 16707.248173832177, 15649.921750391231, 17070.317187312525, 17363.87134836238, 17383.304667813303, 17395.130243487805, 5035.647504674675, 5278.261043453919, 5304.92042619361, 5310.15037593985, 5317.308749862513, 3690.9815450922843, 3866.439366291886, 5208.7395630218525, 5778.971105144489, 6084.939150608504, 6001.879962400772, 6012.18835457212, 6034.125051867477, 6034.818955431344, 6046.12331211974, 5879.441453061952, 5957.225560677106, 6026.4576188143055, 6033.577649564532, 6124.785632502841, 3382.9323413531592, 5101.821436249714, 5333.120035194188, 5342.439043900374, 5380.757865896044, 19142.23431062756, 19511.219551217935, 19525.80474195268, 19549.902250488798, 19590.118444670024, 1774.591843875903, 1863.80430054845, 1902.4673091534391, 2097.685347197917, 2230.955380892373, 12144.574939877062, 12298.754024919452, 12900.870991290061, 13057.804132938014, 13639.249841258727, 1805.5756897129163, 1805.8645601579933, 1812.0667856054142, 1868.4394681595468, 1870.9906450467797, 66170.3382966169, 66662.33337666659, 67254.3274567253, 67626.9999999995, 68938.3106168937, 9410.247180225566, 9417.717468475958, 9579.664711735057, 9707.320487565803, 9847.310688251753, 13239.27184004889, 13412.396442160127, 13414.396352164176, 13415.060945733705, 13439.395227214798, 7079.964600176966, 7102.467314951399, 7150.678219480136, 7226.963865180745, 7270.454715896329, 6799.626020568916, 6802.897956530656, 6819.181698196248, 6949.061876646689, 6952.061471701357, 6039.486643635252, 6072.119542666377, 6139.96930015356, 6204.7828326008375, 6215.0, 1658.3449537432646, 1680.5042512458854, 1691.4587332053625, 1735.719490163592, 1742.2595396956242, 773.2499475508747, 861.763015170833, 930.5626355612851, 948.7153853843819, 1008.1581879131007, 15568.844311556966, 16456.506304810635, 17005.0, 17524.5618859527, 17768.200430980378, 852.6887685994567, 883.5979629268668, 890.5013192612158, 922.3497434308796, 923.810618823153, 9850.556724947395, 9884.209263258923, 9970.351927124713, 10192.592296308212, 10230.437325946996, 339712.0, 352215.0, 352891.0, 353159.0, 353719.0, 43868.122637547705, 67787.66106169537, 69027.0, 70348.6482567594, 72897.0, 858.0775666158779, 945.546137853834, 948.9952550237342, 969.2343048991218, 970.0784254957819, 13722.862771372558, 14485.927570362503, 14511.274436278354, 14569.781453277998, 14920.925395372953, 32663.510047348835, 32711.345773084882, 32825.0, 32978.5053224197, 33744.48149833214, 40446.393304099875, 40496.79751601223, 40897.38653920253, 41072.79463602782, 41609.37585936153, 7532.209118042527, 7711.03612048494, 7798.571078590732, 7857.096433910174, 8030.959845200737, 11240.4379781009, 11458.541658333907, 11501.827472588086, 11815.586454474053, 11955.103367247317, 9220.170184683411, 9789.608415663293, 10348.637797677045, 10389.37663740178, 10521.316114452537, 10073.899261007296, 10099.545520451744, 10137.695869123938, 10162.0, 10535.63125290611, 10283.845742313722, 10502.737431564272, 10579.576816927236, 10663.840042399526, 10886.0, 7638.427117966064, 7680.462367634212, 7702.537847729154, 7838.098618658927, 7949.960250198712, 10503.0, 10650.414227217267, 10686.198535110054, 10780.29928054674, 10881.238313317992], "value": 8230.206882503118, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1236.320023986808, 1379.413749156609, 1418.6949805791753, 1484.829244636867, 1672.7490876368543, 6606.438452731518, 6934.653267336632, 7132.429405647548, 7151.106111736033, 7154.320339567746, 7041.8591628167405, 7046.18968818586, 7096.645167741618, 7104.857902841953, 7111.85776284474, 1866.7479890214784, 2156.385430152399, 2159.8164156046755, 2192.3094225319055, 2193.1556350804976, 2208.6024515587187, 2236.13908645172, 2236.7539570647214, 2237.5636750833596, 2239.2162743039967, 2204.559088182362, 2229.643257078868, 2232.3079845247944, 2235.0, 2239.305815197286, 1787.973180402295, 2122.2253877334815, 2141.4539292480395, 2151.623465893478, 2183.3995651195887, 2165.945851353729, 2170.6526955687173, 2191.912323507074, 2196.461866842618, 2197.5934452126407, 7102.644867756643, 7156.391706704936, 7158.248383919666, 7183.676734546958, 7191.35277824993, 4279.914401711948, 4374.4094547236355, 4393.824247030147, 4394.36281739146, 4401.977990110061, 2746.121241202816, 2815.2539577011903, 2918.9270268243463, 2927.7804164687523, 2945.190072729995, 875.1554749666602, 884.9646014159426, 888.3870129610548, 888.5779254853958, 902.1384577728254, 9609.279304052225, 9637.807243855154, 9661.855072173923, 9662.275329350327, 9676.371035882716, 4020.6381425671243, 4123.175364927027, 4144.0, 4196.643285320782, 4224.176285624274, 8256.504609723435, 8258.174182581693, 8273.875891861628, 8280.254777070093, 8286.751397458085, 4359.651227901761, 4421.226285400042, 4425.867223983286, 4434.866953991385, 4442.400275962704, 3649.6897763690386, 3996.800159991989, 4010.19796040793, 4075.4294398784195, 4114.0948991221885, 3606.2967721294094, 3650.1969566695284, 3698.038509987369, 3702.5927148013698, 3779.3764028934916, 1158.3802665573878, 1158.559747296039, 1183.248637115438, 1183.6094088950626, 1200.8138738495547, 708.7909066825299, 788.3377962511518, 800.3877034068942, 821.3306155483263, 826.2192228344157, 4699.741514216683, 4834.274858771142, 5107.693538387709, 5202.3497062867145, 5239.1093514102695, 854.2269246332079, 859.1408591408591, 874.6807415293372, 896.4397251717677, 907.8275127725711, 3081.938361232763, 3281.261716113903, 3293.6870997255223, 3324.3185147044796, 3381.0871064812854, 8630.741077767678, 8814.647414103363, 8950.14973577509, 9022.097790220925, 9039.909600903908, 8893.555322233991, 8895.4662720237, 8958.283337332998, 8978.68574599899, 8979.191872731355, 6839.31606839322, 6874.0, 6877.724891004304, 6984.755533556403, 7000.194977577644, 4669.906601868011, 4709.48195698466, 4713.0, 4730.511851119501, 4824.807007719652, 8220.383471239562, 8313.251807337369, 8350.916490835014, 8390.244877961013, 8419.8737018946, 8310.459820111673, 8326.375521836007, 8396.496210227406, 8437.873431898404, 8527.957360213408, 5655.943440565707, 6076.118962750288, 6119.418655227746, 6203.2556093269095, 6272.905906411316, 7302.087239095114, 7321.0, 7362.411007119525, 7380.372668323253, 7397.223291554525, 6505.41451269388, 6523.967380163069, 6547.9672601638595, 6573.0, 6704.966475167593, 6556.803295901131, 6590.5716128451495, 6627.237867645283, 6636.5686230396805, 6662.367075127855, 5786.913196302143, 5834.27071616048, 5838.912416313674, 5854.648721076749, 5862.237909071793, 4058.9594104058583, 4323.567643235651, 4341.15347507233, 4383.473983122046, 4414.6625964808545, 4333.6998900329145, 4368.148211098805, 4385.407969924019, 4405.82376704941, 4439.0], "value": 3950.786374072784, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.7259049084352, 309.49397734703757, 310.2383648143807, 312.8248181018631, 313.61738678811855, 4477.507474177846, 4641.6054635355995, 4651.88370290742, 4722.291656251559, 4731.763411829407, 4466.285394336906, 4562.931556026654, 4605.516420775821, 4632.49042605314, 4653.69750966187, 3703.259348130371, 3713.3316003119426, 3714.23858109087, 3722.590515043343, 3725.4039353703415, 3516.226430185355, 3533.240353324035, 3711.109333759905, 3713.2202237530014, 3716.535433070866, 3664.743467957244, 3681.466187402825, 3681.852725890961, 3684.521012268401, 3688.2992231475932, 3643.653852883972, 3652.3425783358985, 3688.5020522229424, 3691.50164727761, 3695.946655203281, 3249.0, 3275.901722948315, 3280.3767284215924, 3293.9835300823343, 3302.3230237801195, 4254.446921900164, 4465.307877279027, 4493.191225579394, 4516.322551617283, 4555.63554915606, 4099.97950010251, 4118.629323360912, 4126.00975765817, 4134.37984302354, 4141.461609990682, 4884.5603895649565, 4893.535114164149, 4905.656604037718, 4912.435069966964, 4937.382827146606, 3311.403947289487, 3497.545319108525, 3503.544539209912, 3512.1570823002553, 3542.167590616203, 5044.319016932704, 5115.590752739809, 5120.207927225479, 5122.974385128088, 5126.179811230222, 3569.3575156472084, 3571.8212989713334, 3575.6245594212755, 3587.3004764070756, 3609.296187243515, 3643.890683279506, 3647.3981793004386, 3647.4893514907935, 3657.5062366580173, 3671.5227020487164, 3903.4925459690626, 4083.060895993938, 4102.056526998807, 4121.649659778953, 4158.979205103955, 4842.128416884924, 4888.877778055577, 4901.034873901239, 4910.435299940481, 4916.803327866845, 1249.6063739921894, 1264.62061381587, 1313.317075120951, 1324.2253281830237, 1325.3704490367, 855.7988872614931, 876.4102078358436, 876.5135349880877, 876.9210771030511, 878.4729162502575, 4611.792469338888, 4628.21813601759, 4628.282616194495, 4628.352030715702, 4631.907361852744, 5349.0, 5355.946440535545, 5360.758765855546, 5366.517013468807, 5380.488853558905, 4505.954940450619, 4599.356090147382, 4609.193391156534, 4622.6764126510825, 4624.907501849944, 2824.5057115004793, 2838.7870909681856, 2839.1908306132655, 2844.7013063628433, 2847.373577812878, 5020.573251273682, 5032.710116896803, 5044.142495775727, 5052.343195384577, 5061.974690126526, 5305.946940530623, 5419.891602167934, 5463.180522921593, 5466.414739725515, 5476.479734425223, 5051.646384753032, 5067.442581316052, 5068.59451243907, 5074.771635276422, 5086.745662716849, 5322.41453440129, 5342.679439233659, 5350.866228344323, 5352.0, 5353.437889021597, 5037.798488060436, 5229.241759944711, 5233.319668443078, 5235.554977826775, 5236.188390799432, 5033.421156567042, 5063.367079115111, 5066.923996139987, 5067.366579177603, 5067.5185857343495, 3730.2539492101146, 3730.3471892418174, 3731.9067023324633, 3734.719896007756, 3742.7192960527523, 4799.712017278975, 5194.039102766001, 5264.6314757966575, 5349.893002140013, 5369.5167434931045, 4761.857144285677, 4873.122837889214, 4946.1591529439365, 4946.925796113133, 4959.578435832995, 4733.3906471799755, 4770.403699537558, 4829.13075646387, 4841.491643377535, 4875.463698993037, 4599.333096701027, 4813.278008298643, 4824.396950381202, 4850.1269771441475, 4859.392575928009, 4929.482404347636, 4959.776810043484, 4969.428515720739, 4980.950190498049, 4984.302197692398, 4842.903141937071, 4850.563449289581, 4865.759231395971, 4881.341018962395, 4886.65793394459], "value": 3780.7295281894603, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [616.8180386785895, 620.4385031546451, 629.3706293706293, 690.9773535167951, 738.1953670499156, 10705.250632455722, 11059.612913548008, 11067.391293478855, 11089.833652495208, 11121.55513779448, 10889.455527223627, 10978.670639880796, 10988.505517251742, 11237.887621123786, 11361.375124368156, 813.3330668851559, 815.7552734179752, 820.5281962871343, 820.6553247636007, 822.2312138150818, 648.7210499485219, 785.2030189357778, 808.7533302342783, 811.2293321344716, 812.7927378518469, 849.6304107713133, 850.2475309351238, 850.4684572142411, 851.4976164063202, 851.8083431227986, 847.9788005299886, 848.9660413583449, 849.379952634574, 849.4393700157927, 850.4259624753266, 499.7501249375312, 604.6795198544778, 612.7518355066205, 619.2166908860295, 620.4385031546458, 11367.147463940237, 11421.0, 11422.600208992728, 11430.314181149075, 11477.0, 10760.40817755023, 11301.943490282578, 11544.480498377594, 11676.416179191006, 11836.526538938431, 9587.424754514752, 9652.276079294012, 9684.661036863676, 9918.603255869828, 9998.900010999869, 3139.8116113033293, 3172.9682703172903, 3202.1834432219866, 3237.2068843133584, 3280.343931213743, 43981.0, 44143.99999999968, 44173.337399939024, 44573.77713111446, 44613.55386446127, 9460.621575136918, 9619.807603847883, 9622.759431014141, 9662.13040826329, 9707.320487565943, 15598.220088995506, 15607.063576185237, 15607.063576185465, 15610.843891561166, 15667.529974100795, 6474.611523308617, 6498.0, 6515.213062130313, 6518.1200537927725, 6832.385085342343, 3486.2330287336745, 3587.192881601619, 3639.763415377992, 3687.465317528943, 3704.240630670706, 2762.778977681781, 2785.3872148127784, 2810.058630358812, 2827.7313655203134, 2830.6461692288462, 491.7860730582137, 497.4801332607434, 501.77169387928404, 501.9723915184627, 504.25118698732354, 475.3867510910955, 509.8878246785701, 519.291167556283, 522.9712365819917, 531.7580500872094, 6964.721411143498, 6976.441884649216, 7031.0, 7054.4003759681, 7245.275472452712, 431.9784010799447, 459.25600527146236, 466.5194849305221, 492.30093267560153, 564.2889958652046, 3183.3951549205576, 3229.870805167814, 3279.4097062528494, 3305.173706573357, 3347.2301370684877, 35670.10824729351, 35822.462663060076, 35956.64043359585, 51396.74301628468, 52472.47527524676, 43749.0, 45231.77384113058, 45534.54465455303, 45952.3107153393, 47635.52364476311, 39992.20015599672, 40324.39513407301, 41071.38392924168, 42656.0, 44183.0, 7348.448866334939, 7382.446316526175, 7544.245575442412, 7571.545707257582, 7592.354649854824, 27901.023464178656, 28958.855205723838, 29273.70726292795, 29580.0, 30030.0, 35984.0, 37907.0, 38340.42489362606, 38496.2300753989, 38697.80651096727, 9309.20871725911, 9511.66709165176, 9578.473183974947, 9592.23262139041, 9638.084381983701, 10213.948930255598, 10452.477376131315, 10532.315399499008, 10758.515866785858, 10889.074428673652, 8959.0, 9182.0, 9184.311176661911, 9378.624855005723, 9494.810103798023, 9705.417674939526, 9731.416115032838, 9932.553035113293, 10052.69841904744, 10190.388576685422, 9131.315151363542, 9162.541872906462, 9313.627454901729, 9455.669051583161, 9672.613095476103, 8281.29608983219, 8326.209010144026, 8432.915670843213, 8780.297576193761, 8802.25180859634, 8348.791280218044, 8403.873941890753, 8511.148885111686, 8565.48607083577, 8682.348823838363], "value": 5507.152558385085, "unit": "score"}], "name": "dromaeo_css", "value": 6144.042382675191, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 109.0, 113.0, 115.0, 115.0, 103.0, 117.0, 114.0, 113.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 132.0, 156.0, 194.0, 132.0, 165.0, 157.0, 140.0, 199.0, 134.0], "value": 156.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 161.0, 162.0, 162.0, 161.0, 165.0, 161.0, 162.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 124.0, 118.0, 74.0, 73.0, 78.0, 115.0, 103.0, 77.0], "value": 91.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 146.0, 94.0, 94.0, 95.0, 141.0, 93.0, 93.0, 137.0], "value": 108.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 116.0, 118.0, 116.0, 116.0, 116.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 147.0, 147.0, 147.0, 146.0, 147.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 69.0, 68.0, 67.0, 68.0, 78.0, 85.0, 67.0, 64.0], "value": 70.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 63.0, 64.0], "value": 63.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 78.0, 78.0, 80.0, 79.0, 80.0, 80.0, 86.0, 80.0], "value": 79.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 132.0, 133.0, 126.0, 131.0, 133.0, 128.0, 136.0, 167.0, 129.0], "value": 135.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 171.0, 173.0, 174.0, 173.0, 176.0, 185.0, 182.0, 171.0, 172.0], "value": 175.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 78.0, 73.0, 73.0, 75.0, 77.0, 75.0, 72.0, 72.0, 70.0], "value": 73.8, "unit": "score"}], "name": "kraken", "value": 1586.6, "alertThreshold": 2.0}]} 12:19:18 INFO - Return code: 0 12:19:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:19:18 ERROR - # TBPL SUCCESS # 12:19:18 INFO - Running post-action listener: _resource_record_post_action 12:19:18 INFO - Running post-run listener: _resource_record_post_run 12:19:19 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 36864; Write bytes: 280567808; Read time: 296; Write time: 192708 12:19:19 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 1183744; Read time: 0; Write time: 48 12:19:19 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 36864; Write bytes: 278245376; Read time: 296; Write time: 192624 12:19:19 INFO - Running post-run listener: _upload_blobber_files 12:19:19 INFO - Blob upload gear active. 12:19:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:19:19 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 12:19:19 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:19:19 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:19:19 INFO - (blobuploader) - INFO - Open directory for files ... 12:19:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:19:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:19:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:19:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:19:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:19:20 INFO - (blobuploader) - INFO - Done attempting. 12:19:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:19:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:19:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:19:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:19:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:19:21 INFO - (blobuploader) - INFO - Done attempting. 12:19:21 INFO - (blobuploader) - INFO - Iteration through files over. 12:19:21 INFO - Return code: 0 12:19:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:19:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:19:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2e63f68575206279da47f29df0fdccd2a4da53733cb5eb0f9d721d5680437e3ae1d4a09fb8b1ab8b91145eaccb93d4e7db75b92ce860398298c8867dc1aa8a68", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6655525a4945d70cddfc0da8b0da2013a65ecaef49bfb453c51a5370f85f76deb2a4c2149ba221e050214e664722f13877fe116c002fc1eda4534d09aacbfe46"} 12:19:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:19:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:19:21 INFO - Contents: 12:19:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2e63f68575206279da47f29df0fdccd2a4da53733cb5eb0f9d721d5680437e3ae1d4a09fb8b1ab8b91145eaccb93d4e7db75b92ce860398298c8867dc1aa8a68", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6655525a4945d70cddfc0da8b0da2013a65ecaef49bfb453c51a5370f85f76deb2a4c2149ba221e050214e664722f13877fe116c002fc1eda4534d09aacbfe46"} 12:19:21 INFO - Running post-run listener: copy_logs_to_upload_dir 12:19:21 INFO - Copying logs to upload dir... 12:19:21 INFO - mkdir: /builds/slave/test/build/upload/logs 12:19:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.050758 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-04-25 12:19:21.290304) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 12:19:21.293464) ========= 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=0e2a256762fed810e2f0f810000001b3-1461610254.908545-2104960304 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2e63f68575206279da47f29df0fdccd2a4da53733cb5eb0f9d721d5680437e3ae1d4a09fb8b1ab8b91145eaccb93d4e7db75b92ce860398298c8867dc1aa8a68", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6655525a4945d70cddfc0da8b0da2013a65ecaef49bfb453c51a5370f85f76deb2a4c2149ba221e050214e664722f13877fe116c002fc1eda4534d09aacbfe46"} build_url:https://queue.taskcluster.net/v1/task/FvDwgoaJSAKnQ9PG_3oVmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011250 build_url: 'https://queue.taskcluster.net/v1/task/FvDwgoaJSAKnQ9PG_3oVmQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2e63f68575206279da47f29df0fdccd2a4da53733cb5eb0f9d721d5680437e3ae1d4a09fb8b1ab8b91145eaccb93d4e7db75b92ce860398298c8867dc1aa8a68", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6655525a4945d70cddfc0da8b0da2013a65ecaef49bfb453c51a5370f85f76deb2a4c2149ba221e050214e664722f13877fe116c002fc1eda4534d09aacbfe46"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 12:19:21.322935) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 12:19:21.323705) ========= 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=0e2a256762fed810e2f0f810000001b3-1461610254.908545-2104960304 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004446 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 12:19:21.406721) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 12:19:21.407400) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 12:19:21.408055) ========= ========= Total master_lag: 0.18 =========