builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-046 starttime: 1461215225.79 results: success (0) buildid: 20160420193352 builduid: 40f232753bdc4e8b8cd0aa5d512e1562 revision: 279dfae6682ff32bf6dfdc77546702d2999481db ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 22:07:05.789638) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 22:07:05.790141) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 22:07:05.790441) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 22:07:05.813467) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 22:07:05.813787) ========= 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=652eb03db935cfc1c15ebda0000001ad-1461214287.617397-209692642 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-20 22:07:06-- 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% 103M=0s 2016-04-20 22:07:06 (103 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.107884 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 22:07:05.955521) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 22:07:05.955821) ========= 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=652eb03db935cfc1c15ebda0000001ad-1461214287.617397-209692642 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018311 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 22:07:06.009503) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 22:07:06.009854) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 279dfae6682ff32bf6dfdc77546702d2999481db --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 279dfae6682ff32bf6dfdc77546702d2999481db --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=652eb03db935cfc1c15ebda0000001ad-1461214287.617397-209692642 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-20 22:07:06,473 truncating revision to first 12 chars 2016-04-20 22:07:06,473 Setting DEBUG logging. 2016-04-20 22:07:06,473 attempt 1/10 2016-04-20 22:07:06,474 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/279dfae6682f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-20 22:07:06,723 unpacking tar archive at: mozilla-inbound-279dfae6682f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.536714 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 22:07:06.563259) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 22:07:06.563538) ========= script_repo_revision: 279dfae6682ff32bf6dfdc77546702d2999481db ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 22:07:06.563926) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 22:07:06.564222) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 22:07:06.574708) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-04-20 22:07:06.575175) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=652eb03db935cfc1c15ebda0000001ad-1461214287.617397-209692642 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:07:07 INFO - MultiFileLogger online at 20160420 22:07:07 in /builds/slave/test 22:07:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 22:07:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:07:07 INFO - {'append_to_log': False, 22:07:07 INFO - 'base_work_dir': '/builds/slave/test', 22:07:07 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 22:07:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:07:07 INFO - 'branch': 'Mozilla-Inbound', 22:07:07 INFO - 'buildbot_json_path': 'buildprops.json', 22:07:07 INFO - 'config_files': ('talos/linux_config.py',), 22:07:07 INFO - 'default_actions': ('clobber', 22:07:07 INFO - 'read-buildbot-config', 22:07:07 INFO - 'download-and-extract', 22:07:07 INFO - 'populate-webroot', 22:07:07 INFO - 'create-virtualenv', 22:07:07 INFO - 'install', 22:07:07 INFO - 'run-tests'), 22:07:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:07:07 INFO - 'download_minidump_stackwalk': True, 22:07:07 INFO - 'download_symbols': 'ondemand', 22:07:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:07:07 INFO - 'tooltool.py': '/tools/tooltool.py', 22:07:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:07:07 INFO - '/tools/misc-python/virtualenv.py')}, 22:07:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:07:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:07:07 INFO - 'installer_path': 'installer.exe', 22:07:07 INFO - 'log_level': 'info', 22:07:07 INFO - 'log_name': 'talos', 22:07:07 INFO - 'log_to_console': True, 22:07:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:07:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:07:07 INFO - 'opt_config_files': (), 22:07:07 INFO - 'pip_index': False, 22:07:07 INFO - 'sps_profile': False, 22:07:07 INFO - 'sps_profile_interval': 0, 22:07:07 INFO - 'suite': 'dromaeojs', 22:07:07 INFO - 'system_bits': '32', 22:07:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:07:07 INFO - 'title': 'talos-linux64-ix-046', 22:07:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:07:07 INFO - 'use_talos_json': True, 22:07:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:07:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:07:07 INFO - 'work_dir': 'build'} 22:07:07 INFO - ##### 22:07:07 INFO - ##### Running clobber step. 22:07:07 INFO - ##### 22:07:07 INFO - Running pre-action listener: _resource_record_pre_action 22:07:07 INFO - Running main action method: clobber 22:07:07 INFO - rmtree: /builds/slave/test/build 22:07:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:07:08 INFO - Running post-action listener: _resource_record_post_action 22:07:08 INFO - ##### 22:07:08 INFO - ##### Running read-buildbot-config step. 22:07:08 INFO - ##### 22:07:08 INFO - Running pre-action listener: _resource_record_pre_action 22:07:08 INFO - Running main action method: read_buildbot_config 22:07:08 INFO - Using buildbot properties: 22:07:08 INFO - { 22:07:08 INFO - "project": "", 22:07:08 INFO - "product": "firefox", 22:07:08 INFO - "script_repo_revision": "production", 22:07:08 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 22:07:08 INFO - "repository": "", 22:07:08 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 22:07:08 INFO - "buildid": "20160420193352", 22:07:08 INFO - "pgo_build": "True", 22:07:08 INFO - "basedir": "/builds/slave/test", 22:07:08 INFO - "buildnumber": 1735, 22:07:08 INFO - "slavename": "talos-linux64-ix-046", 22:07:08 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:07:08 INFO - "platform": "ubuntu64_hw", 22:07:08 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 22:07:08 INFO - "branch": "mozilla-inbound", 22:07:08 INFO - "repo_path": "integration/mozilla-inbound", 22:07:08 INFO - "revision": "279dfae6682ff32bf6dfdc77546702d2999481db", 22:07:08 INFO - "stage_platform": "linux64-pgo", 22:07:08 INFO - "builduid": "40f232753bdc4e8b8cd0aa5d512e1562", 22:07:08 INFO - "slavebuilddir": "test" 22:07:08 INFO - } 22:07:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 22:07:08 INFO - Running post-action listener: _resource_record_post_action 22:07:08 INFO - ##### 22:07:08 INFO - ##### Running download-and-extract step. 22:07:08 INFO - ##### 22:07:08 INFO - Running pre-action listener: _resource_record_pre_action 22:07:08 INFO - Running main action method: download_and_extract 22:07:08 INFO - mkdir: /builds/slave/test/build/tests 22:07:08 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')]} 22:07:08 INFO - https://queue.taskcluster.net/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:07:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:07:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:07:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:07:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:07:10 INFO - Downloaded 1361 bytes. 22:07:10 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:07:10 INFO - Using the following test package requirements: 22:07:10 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:07:10 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:07:10 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:07:10 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:07:10 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:07:10 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:07:10 INFO - u'jsshell-linux-x86_64.zip'], 22:07:10 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:07:10 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:07:10 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:07:10 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:07:10 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:07:10 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:07:10 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:07:10 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:07:10 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:07:10 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:07:10 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:07:10 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:07:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:10 INFO - https://queue.taskcluster.net/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:07:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:07:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:07:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:07:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:07:11 INFO - Downloaded 23849222 bytes. 22:07:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:07:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:07:12 INFO - Return code: 0 22:07:12 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:07:12 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')]} 22:07:12 INFO - https://queue.taskcluster.net/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:07:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:07:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:07:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:07:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:07:15 INFO - Downloaded 23849222 bytes. 22:07:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:07:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:07:17 INFO - Return code: 0 22:07:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:17 INFO - https://queue.taskcluster.net/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:07:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:07:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:07:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:07:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:07:18 INFO - Downloaded 10845952 bytes. 22:07:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:07:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 22:07:18 INFO - Return code: 0 22:07:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:18 INFO - https://queue.taskcluster.net/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:07:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:07:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:07:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:07:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:07:20 INFO - Downloaded 58323054 bytes. 22:07:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:07:20 INFO - mkdir: /builds/slave/test/properties 22:07:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:07:20 INFO - Writing to file /builds/slave/test/properties/build_url 22:07:20 INFO - Contents: 22:07:20 INFO - build_url:https://queue.taskcluster.net/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:07:21 INFO - Running post-action listener: _resource_record_post_action 22:07:21 INFO - Running post-action listener: set_extra_try_arguments 22:07:21 INFO - ##### 22:07:21 INFO - ##### Running populate-webroot step. 22:07:21 INFO - ##### 22:07:21 INFO - Running pre-action listener: _resource_record_pre_action 22:07:21 INFO - Running main action method: populate_webroot 22:07:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:07:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:07:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:07:21 INFO - '--tppagecycles', 22:07:21 INFO - '7'], 22:07:21 INFO - 'tests': ['tsvgm']}}, 22:07:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:07:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:07:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:07:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:07:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:07:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:07:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:21 INFO - 'talos_options': ['--disable-e10s'], 22:07:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:07:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:07:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:21 INFO - 'talos_options': ['--disable-e10s'], 22:07:21 INFO - 'tests': ['damp', 'tps']}, 22:07:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:21 INFO - 'tests': ['damp', 'tps']}, 22:07:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:07:21 INFO - 'tests': ['dromaeo_dom']}, 22:07:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:07:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:07:21 INFO - 'tests': ['a11yr', 22:07:21 INFO - 'ts_paint', 22:07:21 INFO - 'tpaint', 22:07:21 INFO - 'sessionrestore', 22:07:21 INFO - 'sessionrestore_no_auto_restore', 22:07:21 INFO - 'tabpaint']}, 22:07:21 INFO - 'other-e10s': {'tests': ['a11yr', 22:07:21 INFO - 'ts_paint', 22:07:21 INFO - 'tpaint', 22:07:21 INFO - 'sessionrestore', 22:07:21 INFO - 'sessionrestore_no_auto_restore', 22:07:21 INFO - 'tabpaint']}, 22:07:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:07:21 INFO - 'ts_paint', 22:07:21 INFO - 'tpaint', 22:07:21 INFO - 'sessionrestore', 22:07:21 INFO - 'sessionrestore_no_auto_restore', 22:07:21 INFO - 'tabpaint']}, 22:07:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:07:21 INFO - 'ts_paint', 22:07:21 INFO - 'tpaint', 22:07:21 INFO - 'sessionrestore', 22:07:21 INFO - 'sessionrestore_no_auto_restore', 22:07:21 INFO - 'tabpaint']}, 22:07:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:07:21 INFO - 'tests': ['a11yr', 22:07:21 INFO - 'ts_paint', 22:07:21 INFO - 'tpaint', 22:07:21 INFO - 'sessionrestore', 22:07:21 INFO - 'sessionrestore_no_auto_restore', 22:07:21 INFO - 'tabpaint']}, 22:07:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:07:21 INFO - 'tests': ['a11yr', 22:07:21 INFO - 'ts_paint', 22:07:21 INFO - 'tpaint', 22:07:21 INFO - 'sessionrestore', 22:07:21 INFO - 'sessionrestore_no_auto_restore', 22:07:21 INFO - 'tabpaint']}, 22:07:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:07:21 INFO - 'tests': ['tsvgx', 22:07:21 INFO - 'tsvgr_opacity', 22:07:21 INFO - 'tart', 22:07:21 INFO - 'tscrollx', 22:07:21 INFO - 'cart']}, 22:07:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:07:21 INFO - 'tsvgr_opacity', 22:07:21 INFO - 'tart', 22:07:21 INFO - 'tscrollx', 22:07:21 INFO - 'cart']}, 22:07:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:21 INFO - 'talos_options': ['--disable-e10s'], 22:07:21 INFO - 'tests': ['tp5o']}, 22:07:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:21 INFO - 'tests': ['tp5o']}, 22:07:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:21 INFO - 'talos_options': ['--disable-e10s', 22:07:21 INFO - '--xperf_path', 22:07:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:07:21 INFO - 'tests': ['tp5n']}, 22:07:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:21 INFO - 'talos_options': ['--xperf_path', 22:07:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:07:21 INFO - 'tests': ['tp5n']}}, 22:07:21 INFO - 'talos.zip': {'path': '', 22:07:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:07:21 INFO - Running post-action listener: _resource_record_post_action 22:07:21 INFO - ##### 22:07:21 INFO - ##### Running create-virtualenv step. 22:07:21 INFO - ##### 22:07:21 INFO - Running pre-action listener: _resource_record_pre_action 22:07:21 INFO - Running main action method: create_virtualenv 22:07:21 INFO - Creating virtualenv /builds/slave/test/build/venv 22:07:21 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 22:07:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:07:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:07:21 INFO - Using real prefix '/usr' 22:07:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:07:21 INFO - Installing distribute.............................................................................................................................................................................................done. 22:07:23 INFO - Installing pip.................done. 22:07:23 INFO - Return code: 0 22:07:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:07:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2cc72ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144f410>, '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 0x1450310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14507a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1461214287.617397-209692642', '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 22:07:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:07:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:07:23 INFO - Using env: {'DISPLAY': ':0', 22:07:23 INFO - 'HOME': '/home/cltbld', 22:07:23 INFO - 'LANG': 'en_US.UTF-8', 22:07:23 INFO - 'LANGUAGE': 'en_US:en', 22:07:23 INFO - 'LOGNAME': 'cltbld', 22:07:23 INFO - 'MAIL': '/var/mail/cltbld', 22:07:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:23 INFO - 'MOZ_NO_REMOTE': '1', 22:07:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:23 INFO - 'NO_EM_RESTART': '1', 22:07:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:07:23 INFO - 'PWD': '/builds/slave/test', 22:07:23 INFO - 'SHELL': '/bin/bash', 22:07:23 INFO - 'SHLVL': '1', 22:07:23 INFO - 'TERM': 'linux', 22:07:23 INFO - 'TMOUT': '86400', 22:07:23 INFO - 'USER': 'cltbld', 22:07:23 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1461214287.617397-209692642', 22:07:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:23 INFO - '_': '/tools/buildbot/bin/python'} 22:07:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:23 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 22:07:23 INFO - Cleaning up... 22:07:23 INFO - Return code: 0 22:07:23 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:07:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe2cc72ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144f410>, '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 0x1450310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14507a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1461214287.617397-209692642', '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 22:07:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 22:07:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 22:07:23 INFO - Using env: {'DISPLAY': ':0', 22:07:23 INFO - 'HOME': '/home/cltbld', 22:07:23 INFO - 'LANG': 'en_US.UTF-8', 22:07:23 INFO - 'LANGUAGE': 'en_US:en', 22:07:23 INFO - 'LOGNAME': 'cltbld', 22:07:23 INFO - 'MAIL': '/var/mail/cltbld', 22:07:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:23 INFO - 'MOZ_NO_REMOTE': '1', 22:07:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:23 INFO - 'NO_EM_RESTART': '1', 22:07:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:07:23 INFO - 'PWD': '/builds/slave/test', 22:07:23 INFO - 'SHELL': '/bin/bash', 22:07:23 INFO - 'SHLVL': '1', 22:07:23 INFO - 'TERM': 'linux', 22:07:23 INFO - 'TMOUT': '86400', 22:07:23 INFO - 'USER': 'cltbld', 22:07:23 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1461214287.617397-209692642', 22:07:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:23 INFO - '_': '/tools/buildbot/bin/python'} 22:07:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:24 INFO - Downloading/unpacking psutil>=0.7.1 22:07:24 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 22:07:24 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 22:07:24 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 22:07:24 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 22:07:24 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 22:07:24 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 22:07:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:07:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:07:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:07:26 INFO - Installing collected packages: psutil 22:07:26 INFO - Running setup.py install for psutil 22:07:26 INFO - building 'psutil._psutil_linux' extension 22:07:26 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 22:07:26 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 22:07:26 INFO - building 'psutil._psutil_posix' extension 22:07:26 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 22:07:26 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 22:07:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:07:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:07:26 INFO - Successfully installed psutil 22:07:26 INFO - Cleaning up... 22:07:26 INFO - Return code: 0 22:07:26 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:07:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:26 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 0x7fe2cc72ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144f410>, '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 0x1450310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14507a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1461214287.617397-209692642', '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 22:07:26 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 22:07:26 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 22:07:26 INFO - Using env: {'DISPLAY': ':0', 22:07:26 INFO - 'HOME': '/home/cltbld', 22:07:26 INFO - 'LANG': 'en_US.UTF-8', 22:07:26 INFO - 'LANGUAGE': 'en_US:en', 22:07:26 INFO - 'LOGNAME': 'cltbld', 22:07:26 INFO - 'MAIL': '/var/mail/cltbld', 22:07:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:26 INFO - 'MOZ_NO_REMOTE': '1', 22:07:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:26 INFO - 'NO_EM_RESTART': '1', 22:07:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:07:26 INFO - 'PWD': '/builds/slave/test', 22:07:26 INFO - 'SHELL': '/bin/bash', 22:07:26 INFO - 'SHLVL': '1', 22:07:26 INFO - 'TERM': 'linux', 22:07:26 INFO - 'TMOUT': '86400', 22:07:26 INFO - 'USER': 'cltbld', 22:07:26 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1461214287.617397-209692642', 22:07:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:26 INFO - '_': '/tools/buildbot/bin/python'} 22:07:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:26 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:07:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:28 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:07:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:07:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:07:28 INFO - Installing collected packages: mozsystemmonitor 22:07:28 INFO - Running setup.py install for mozsystemmonitor 22:07:28 INFO - Successfully installed mozsystemmonitor 22:07:28 INFO - Cleaning up... 22:07:28 INFO - Return code: 0 22:07:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:07:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:28 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 0x7fe2cc72ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144f410>, '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 0x1450310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14507a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1461214287.617397-209692642', '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 22:07:28 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 22:07:28 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 22:07:28 INFO - Using env: {'DISPLAY': ':0', 22:07:28 INFO - 'HOME': '/home/cltbld', 22:07:28 INFO - 'LANG': 'en_US.UTF-8', 22:07:28 INFO - 'LANGUAGE': 'en_US:en', 22:07:28 INFO - 'LOGNAME': 'cltbld', 22:07:28 INFO - 'MAIL': '/var/mail/cltbld', 22:07:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:28 INFO - 'MOZ_NO_REMOTE': '1', 22:07:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:28 INFO - 'NO_EM_RESTART': '1', 22:07:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:07:28 INFO - 'PWD': '/builds/slave/test', 22:07:28 INFO - 'SHELL': '/bin/bash', 22:07:28 INFO - 'SHLVL': '1', 22:07:28 INFO - 'TERM': 'linux', 22:07:28 INFO - 'TMOUT': '86400', 22:07:28 INFO - 'USER': 'cltbld', 22:07:28 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1461214287.617397-209692642', 22:07:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:28 INFO - '_': '/tools/buildbot/bin/python'} 22:07:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:29 INFO - Downloading/unpacking blobuploader==1.2.4 22:07:29 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 22:07:29 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 22:07:29 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 22:07:29 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 22:07:29 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 22:07:29 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 22:07:31 INFO - Downloading blobuploader-1.2.4.tar.gz 22:07:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:07:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:07:31 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 22:07:31 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 22:07:31 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 22:07:31 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 22:07:31 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 22:07:31 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 22:07:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:07:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:07:31 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 22:07:31 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 22:07:31 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 22:07:31 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 22:07:31 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 22:07:31 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 22:07:31 INFO - Downloading docopt-0.6.1.tar.gz 22:07:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:07:31 INFO - Installing collected packages: blobuploader, requests, docopt 22:07:31 INFO - Running setup.py install for blobuploader 22:07:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:07:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:07:31 INFO - Running setup.py install for requests 22:07:32 INFO - Running setup.py install for docopt 22:07:32 INFO - Successfully installed blobuploader requests docopt 22:07:32 INFO - Cleaning up... 22:07:32 INFO - Return code: 0 22:07:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:07:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:32 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 0x7fe2cc72ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144f410>, '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 0x1450310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14507a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1461214287.617397-209692642', '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 22:07:32 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 22:07:32 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 22:07:32 INFO - Using env: {'DISPLAY': ':0', 22:07:32 INFO - 'HOME': '/home/cltbld', 22:07:32 INFO - 'LANG': 'en_US.UTF-8', 22:07:32 INFO - 'LANGUAGE': 'en_US:en', 22:07:32 INFO - 'LOGNAME': 'cltbld', 22:07:32 INFO - 'MAIL': '/var/mail/cltbld', 22:07:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:32 INFO - 'MOZ_NO_REMOTE': '1', 22:07:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:32 INFO - 'NO_EM_RESTART': '1', 22:07:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:07:32 INFO - 'PWD': '/builds/slave/test', 22:07:32 INFO - 'SHELL': '/bin/bash', 22:07:32 INFO - 'SHLVL': '1', 22:07:32 INFO - 'TERM': 'linux', 22:07:32 INFO - 'TMOUT': '86400', 22:07:32 INFO - 'USER': 'cltbld', 22:07:32 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1461214287.617397-209692642', 22:07:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:32 INFO - '_': '/tools/buildbot/bin/python'} 22:07:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:07:32 INFO - Running setup.py (path:/tmp/pip-leSSzb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:07:32 INFO - Running setup.py (path:/tmp/pip-N6AdQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:07:32 INFO - Running setup.py (path:/tmp/pip-NjlUOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:07:32 INFO - Running setup.py (path:/tmp/pip-hNUIiS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:07:32 INFO - Running setup.py (path:/tmp/pip-7yzbLG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:07:32 INFO - Running setup.py (path:/tmp/pip-iGYK9Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:07:33 INFO - Running setup.py (path:/tmp/pip-0HevDm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:07:33 INFO - Running setup.py (path:/tmp/pip-xxM9Od-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:07:33 INFO - Running setup.py (path:/tmp/pip-7_nIrT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:07:33 INFO - Running setup.py (path:/tmp/pip-yCIhen-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:07:33 INFO - Running setup.py (path:/tmp/pip-98Wz_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:07:33 INFO - Running setup.py (path:/tmp/pip-gamlE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:07:33 INFO - Running setup.py (path:/tmp/pip-JE7UOq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:07:33 INFO - Running setup.py (path:/tmp/pip-wRMPR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:07:33 INFO - Running setup.py (path:/tmp/pip-RU6VGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:07:33 INFO - Running setup.py (path:/tmp/pip-nqFXnT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:07:33 INFO - Running setup.py (path:/tmp/pip-iVE2NG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:07:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:07:33 INFO - Running setup.py install for manifestparser 22:07:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:07:33 INFO - Running setup.py install for mozcrash 22:07:34 INFO - Running setup.py install for mozdebug 22:07:34 INFO - Running setup.py install for mozdevice 22:07:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:07:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:07:34 INFO - Running setup.py install for mozfile 22:07:34 INFO - Running setup.py install for mozhttpd 22:07:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:07:34 INFO - Running setup.py install for mozinfo 22:07:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:07:34 INFO - Running setup.py install for mozInstall 22:07:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:07:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:07:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:07:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:07:34 INFO - Running setup.py install for mozleak 22:07:34 INFO - Running setup.py install for mozlog 22:07:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:07:34 INFO - Running setup.py install for moznetwork 22:07:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:07:34 INFO - Running setup.py install for mozprocess 22:07:35 INFO - Running setup.py install for mozprofile 22:07:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:07:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:07:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:07:35 INFO - Running setup.py install for mozrunner 22:07:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:07:35 INFO - Running setup.py install for mozscreenshot 22:07:35 INFO - Running setup.py install for moztest 22:07:35 INFO - Running setup.py install for mozversion 22:07:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:07:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:07:35 INFO - Cleaning up... 22:07:35 INFO - Return code: 0 22:07:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:07: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')]} 22:07:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07: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')]} 22:07:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:35 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 0x7fe2cc72ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144f410>, '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 0x1450310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14507a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1461214287.617397-209692642', '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 22:07:35 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 22:07:35 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 22:07:35 INFO - Using env: {'DISPLAY': ':0', 22:07:35 INFO - 'HOME': '/home/cltbld', 22:07:35 INFO - 'LANG': 'en_US.UTF-8', 22:07:35 INFO - 'LANGUAGE': 'en_US:en', 22:07:35 INFO - 'LOGNAME': 'cltbld', 22:07:35 INFO - 'MAIL': '/var/mail/cltbld', 22:07:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:35 INFO - 'MOZ_NO_REMOTE': '1', 22:07:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:35 INFO - 'NO_EM_RESTART': '1', 22:07:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:07:35 INFO - 'PWD': '/builds/slave/test', 22:07:35 INFO - 'SHELL': '/bin/bash', 22:07:35 INFO - 'SHLVL': '1', 22:07:35 INFO - 'TERM': 'linux', 22:07:35 INFO - 'TMOUT': '86400', 22:07:35 INFO - 'USER': 'cltbld', 22:07:35 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1461214287.617397-209692642', 22:07:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:35 INFO - '_': '/tools/buildbot/bin/python'} 22:07:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:07:35 INFO - Running setup.py (path:/tmp/pip-DtTrzb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:07:35 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)) 22:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:07:35 INFO - Running setup.py (path:/tmp/pip-rU85d6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:07:35 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)) 22:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:07:35 INFO - Running setup.py (path:/tmp/pip-cVBopJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:07:36 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)) 22:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:07:36 INFO - Running setup.py (path:/tmp/pip-s73Lol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:07:36 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)) 22:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:07:36 INFO - Running setup.py (path:/tmp/pip-pB8AFp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:07:36 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)) 22:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:07:36 INFO - Running setup.py (path:/tmp/pip-RFA6eK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:07:36 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)) 22:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:07:36 INFO - Running setup.py (path:/tmp/pip-o66wR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:07:36 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)) 22:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:07:36 INFO - Running setup.py (path:/tmp/pip-skUOlE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:07:36 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)) 22:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:07:36 INFO - Running setup.py (path:/tmp/pip-hVoGDS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:07:36 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)) 22:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:07:36 INFO - Running setup.py (path:/tmp/pip-2j2pIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:07:36 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)) 22:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:07:36 INFO - Running setup.py (path:/tmp/pip-qeeeoF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:07:36 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)) 22:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:07:36 INFO - Running setup.py (path:/tmp/pip-wLqGok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:07:36 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)) 22:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:07:36 INFO - Running setup.py (path:/tmp/pip-mxkHqj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:07:36 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)) 22:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:07:36 INFO - Running setup.py (path:/tmp/pip-IQjCty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:07:36 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)) 22:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:07:36 INFO - Running setup.py (path:/tmp/pip-a_BK4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:07:36 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)) 22:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:07:36 INFO - Running setup.py (path:/tmp/pip-NoqoN_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:07:37 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)) 22:07:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:07:37 INFO - Running setup.py (path:/tmp/pip-vgL7sF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:07:37 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)) 22:07:37 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)) 22:07:37 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)) 22:07:37 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)) 22:07:37 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)) 22:07:37 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)) 22:07:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:07:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:38 INFO - Downloading blessings-1.6.tar.gz 22:07:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:07:39 INFO - Installing collected packages: blessings 22:07:39 INFO - Running setup.py install for blessings 22:07:39 INFO - Successfully installed blessings 22:07:39 INFO - Cleaning up... 22:07:39 INFO - Return code: 0 22:07:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:07:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:07:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:07:39 INFO - Reading from file tmpfile_stdout 22:07:39 INFO - Current package versions: 22:07:39 INFO - argparse == 1.2.1 22:07:39 INFO - blessings == 1.6 22:07:39 INFO - blobuploader == 1.2.4 22:07:39 INFO - docopt == 0.6.1 22:07:39 INFO - manifestparser == 1.1 22:07:39 INFO - mozInstall == 1.12 22:07:39 INFO - mozcrash == 0.17 22:07:39 INFO - mozdebug == 0.1 22:07:39 INFO - mozdevice == 0.48 22:07:39 INFO - mozfile == 1.2 22:07:39 INFO - mozhttpd == 0.7 22:07:39 INFO - mozinfo == 0.9 22:07:39 INFO - mozleak == 0.1 22:07:39 INFO - mozlog == 3.1 22:07:39 INFO - moznetwork == 0.27 22:07:39 INFO - mozprocess == 0.22 22:07:39 INFO - mozprofile == 0.28 22:07:39 INFO - mozrunner == 6.11 22:07:39 INFO - mozscreenshot == 0.1 22:07:39 INFO - mozsystemmonitor == 0.0 22:07:39 INFO - moztest == 0.7 22:07:39 INFO - mozversion == 1.4 22:07:39 INFO - psutil == 3.1.1 22:07:39 INFO - requests == 1.2.3 22:07:39 INFO - wsgiref == 0.1.2 22:07:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:07:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:39 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 0x7fe2cc72ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144f410>, '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 0x1450310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14507a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1461214287.617397-209692642', '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 22:07:39 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 22:07:39 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 22:07:39 INFO - Using env: {'DISPLAY': ':0', 22:07:39 INFO - 'HOME': '/home/cltbld', 22:07:39 INFO - 'LANG': 'en_US.UTF-8', 22:07:39 INFO - 'LANGUAGE': 'en_US:en', 22:07:39 INFO - 'LOGNAME': 'cltbld', 22:07:39 INFO - 'MAIL': '/var/mail/cltbld', 22:07:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:39 INFO - 'MOZ_NO_REMOTE': '1', 22:07:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:39 INFO - 'NO_EM_RESTART': '1', 22:07:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:07:39 INFO - 'PWD': '/builds/slave/test', 22:07:39 INFO - 'SHELL': '/bin/bash', 22:07:39 INFO - 'SHLVL': '1', 22:07:39 INFO - 'TERM': 'linux', 22:07:39 INFO - 'TMOUT': '86400', 22:07:39 INFO - 'USER': 'cltbld', 22:07:39 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1461214287.617397-209692642', 22:07:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:39 INFO - '_': '/tools/buildbot/bin/python'} 22:07:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:39 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)) 22:07:39 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)) 22:07:39 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)) 22:07:39 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)) 22:07:39 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)) 22:07:39 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)) 22:07:39 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)) 22:07:39 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)) 22:07:39 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)) 22:07:39 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)) 22:07:39 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)) 22:07:39 INFO - Cleaning up... 22:07:39 INFO - Return code: 0 22:07:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:07:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:39 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 0x7fe2cc72ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144f410>, '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 0x1450310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14507a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1461214287.617397-209692642', '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 22:07:39 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 22:07:39 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 22:07:39 INFO - Using env: {'DISPLAY': ':0', 22:07:39 INFO - 'HOME': '/home/cltbld', 22:07:39 INFO - 'LANG': 'en_US.UTF-8', 22:07:39 INFO - 'LANGUAGE': 'en_US:en', 22:07:39 INFO - 'LOGNAME': 'cltbld', 22:07:39 INFO - 'MAIL': '/var/mail/cltbld', 22:07:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:39 INFO - 'MOZ_NO_REMOTE': '1', 22:07:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:39 INFO - 'NO_EM_RESTART': '1', 22:07:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:07:39 INFO - 'PWD': '/builds/slave/test', 22:07:39 INFO - 'SHELL': '/bin/bash', 22:07:39 INFO - 'SHLVL': '1', 22:07:39 INFO - 'TERM': 'linux', 22:07:39 INFO - 'TMOUT': '86400', 22:07:39 INFO - 'USER': 'cltbld', 22:07:39 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1461214287.617397-209692642', 22:07:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:39 INFO - '_': '/tools/buildbot/bin/python'} 22:07:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:39 INFO - Downloading/unpacking jsonschema 22:07:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:07:41 INFO - Downloading/unpacking functools32 (from jsonschema) 22:07:41 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 22:07:41 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 22:07:41 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 22:07:41 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 22:07:41 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 22:07:41 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 22:07:41 INFO - Downloading functools32-3.2.3-2.tar.gz 22:07:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:07:41 INFO - warning: no files found matching '*.txt' 22:07:41 INFO - no previously-included directories found matching 'build' 22:07:41 INFO - no previously-included directories found matching 'dist' 22:07:41 INFO - no previously-included directories found matching '.git*' 22:07:41 INFO - Installing collected packages: jsonschema, functools32 22:07:42 INFO - Running setup.py install for functools32 22:07:42 INFO - warning: no files found matching '*.txt' 22:07:42 INFO - no previously-included directories found matching 'build' 22:07:42 INFO - no previously-included directories found matching 'dist' 22:07:42 INFO - no previously-included directories found matching '.git*' 22:07:42 INFO - Successfully installed jsonschema functools32 22:07:42 INFO - Cleaning up... 22:07:42 INFO - Return code: 0 22:07:42 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:07:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2cc72ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144f410>, '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 0x1450310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14507a0>, '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': '652eb03db935cfc1c15ebda0000001ad-1461214287.617397-209692642', '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 22:07:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 22:07:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 22:07:42 INFO - Using env: {'DISPLAY': ':0', 22:07:42 INFO - 'HOME': '/home/cltbld', 22:07:42 INFO - 'LANG': 'en_US.UTF-8', 22:07:42 INFO - 'LANGUAGE': 'en_US:en', 22:07:42 INFO - 'LOGNAME': 'cltbld', 22:07:42 INFO - 'MAIL': '/var/mail/cltbld', 22:07:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:42 INFO - 'MOZ_NO_REMOTE': '1', 22:07:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:42 INFO - 'NO_EM_RESTART': '1', 22:07:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:07:42 INFO - 'PWD': '/builds/slave/test', 22:07:42 INFO - 'SHELL': '/bin/bash', 22:07:42 INFO - 'SHLVL': '1', 22:07:42 INFO - 'TERM': 'linux', 22:07:42 INFO - 'TMOUT': '86400', 22:07:42 INFO - 'USER': 'cltbld', 22:07:42 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1461214287.617397-209692642', 22:07:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:42 INFO - '_': '/tools/buildbot/bin/python'} 22:07:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:42 INFO - Downloading/unpacking flake8 22:07:42 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 22:07:42 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 22:07:42 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 22:07:42 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 22:07:42 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 22:07:42 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 22:07:44 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:07:44 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:07:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:44 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:07:44 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:07:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:44 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:07:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:07:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:07:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:07:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:07:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:07:44 INFO - no previously-included directories found matching 'docs/_build' 22:07:44 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:07:45 INFO - Running setup.py install for pep8 22:07:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:07:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:07:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:07:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:07:45 INFO - no previously-included directories found matching 'docs/_build' 22:07:45 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:07:45 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:07:45 INFO - Cleaning up... 22:07:45 INFO - Return code: 0 22:07:45 INFO - Running post-action listener: _resource_record_post_action 22:07:45 INFO - Running post-action listener: _start_resource_monitoring 22:07:45 INFO - Starting resource monitoring. 22:07:45 INFO - ##### 22:07:45 INFO - ##### Running install step. 22:07:45 INFO - ##### 22:07:45 INFO - Running pre-action listener: _resource_record_pre_action 22:07:45 INFO - Running main action method: install 22:07:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:07:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:07:45 INFO - Reading from file tmpfile_stdout 22:07:45 INFO - Detecting whether we're running mozinstall >=1.0... 22:07:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:07:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:07:45 INFO - Reading from file tmpfile_stdout 22:07:45 INFO - Output received: 22:07:45 INFO - Usage: mozinstall [options] installer 22:07:45 INFO - Options: 22:07:45 INFO - -h, --help show this help message and exit 22:07:45 INFO - -d DEST, --destination=DEST 22:07:45 INFO - Directory to install application into. [default: 22:07:45 INFO - "/builds/slave/test"] 22:07:45 INFO - --app=APP Application being installed. [default: firefox] 22:07:45 INFO - mkdir: /builds/slave/test/build/application 22:07:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:07:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:08:02 INFO - Reading from file tmpfile_stdout 22:08:02 INFO - Output received: 22:08:02 INFO - /builds/slave/test/build/application/firefox/firefox 22:08:02 INFO - Running post-action listener: _resource_record_post_action 22:08:02 INFO - ##### 22:08:02 INFO - ##### Running run-tests step. 22:08:02 INFO - ##### 22:08:02 INFO - Running pre-action listener: _resource_record_pre_action 22:08:02 INFO - Running main action method: run_tests 22:08:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:08:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:08:02 INFO - Python 2.7.3 22:08:02 INFO - Return code: 0 22:08:02 INFO - grabbing minidump binary from tooltool 22:08: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')]} 22:08:02 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 0x144f410>, '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 0x1450310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14507a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:08:02 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 22:08:02 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 22:08:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:08:02 INFO - Return code: 0 22:08:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:08:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:08:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:08:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:08:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:08:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:08:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:08:03 INFO - Return code: 0 22:08:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 22:08:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --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 22:08:03 INFO - Using env: {'DISPLAY': ':0', 22:08:03 INFO - 'HOME': '/home/cltbld', 22:08:03 INFO - 'LANG': 'en_US.UTF-8', 22:08:03 INFO - 'LANGUAGE': 'en_US:en', 22:08:03 INFO - 'LOGNAME': 'cltbld', 22:08:03 INFO - 'MAIL': '/var/mail/cltbld', 22:08:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:08:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:08:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:03 INFO - 'MOZ_NO_REMOTE': '1', 22:08:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:08:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:03 INFO - 'NO_EM_RESTART': '1', 22:08:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:03 INFO - 'PWD': '/builds/slave/test', 22:08:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:08:03 INFO - 'SHELL': '/bin/bash', 22:08:03 INFO - 'SHLVL': '1', 22:08:03 INFO - 'TERM': 'linux', 22:08:03 INFO - 'TMOUT': '86400', 22:08:03 INFO - 'USER': 'cltbld', 22:08:03 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1461214287.617397-209692642', 22:08:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:03 INFO - '_': '/tools/buildbot/bin/python'} 22:08:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 22:08:03 INFO - mozversion application_buildid: 20160420193352 22:08:03 INFO - mozversion application_changeset: 279dfae6682ff32bf6dfdc77546702d2999481db 22:08:03 INFO - mozversion application_display_name: Nightly 22:08:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:08:03 INFO - mozversion application_name: Firefox 22:08:03 INFO - mozversion application_remotingname: firefox 22:08:03 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:08:03 INFO - mozversion application_vendor: Mozilla 22:08:03 INFO - mozversion application_version: 48.0a1 22:08:03 INFO - mozversion platform_buildid: 20160420193352 22:08:03 INFO - mozversion platform_changeset: 279dfae6682ff32bf6dfdc77546702d2999481db 22:08:03 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:08:03 INFO - mozversion platform_version: 48.0a1 22:08:03 INFO - using testdate: 1461215283 22:08:03 INFO - actual date: 1461215283 22:08:03 INFO - starting webserver on 'localhost:58153' 22:08:03 INFO - SUITE-START | Running 2 tests 22:08:03 INFO - TEST-START | dromaeo_css 22:08:03 INFO - operating with platform_type : linux_ 22:08:03 INFO - Initialising browser for dromaeo_css test... 22:08:03 INFO - TEST-INFO | started process 22460 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4b_J2J/profile http://localhost:58153/getInfo.html) 22:08:07 INFO - PROCESS | 22460 | __metrics Screen width/height:1600/1200 22:08:07 INFO - PROCESS | 22460 | colorDepth:24 22:08:07 INFO - PROCESS | 22460 | Browser inner width/height: 1024/697 22:08:07 INFO - PROCESS | 22460 | __metrics 22:08:08 ERROR - PROCESS | 22460 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:08:09 INFO - TEST-INFO | 22460: exit 0 22:08:09 INFO - Browser initialized. 22:08:09 INFO - Running cycle 1/1 for dromaeo_css test... 22:08:09 INFO - TEST-INFO | started process 22539 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4b_J2J/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:08:21 INFO - PROCESS | 22539 | RSS: Main: 153477120 22:08:21 INFO - PROCESS | 22539 | 22:09:12 INFO - PROCESS | 22539 | 1461215352054 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] 22:11:19 INFO - PROCESS | 22539 | Cycle 1(1): loaded http://localhost:58153/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58153/tests/dromaeo/cssquery-ext.html) 22:11:20 INFO - PROCESS | 22539 | RSS: Main: 250814464 22:11:20 INFO - PROCESS | 22539 | 22:14:22 INFO - PROCESS | 22539 | Cycle 1(1): loaded http://localhost:58153/tests/dromaeo/cssquery-ext.html (next: http://localhost:58153/tests/dromaeo/cssquery-jquery.html) 22:14:23 INFO - PROCESS | 22539 | RSS: Main: 234381312 22:14:23 INFO - PROCESS | 22539 | 22:17:25 INFO - PROCESS | 22539 | Cycle 1(1): loaded http://localhost:58153/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58153/tests/dromaeo/cssquery-mootools.html) 22:17:25 INFO - PROCESS | 22539 | RSS: Main: 236646400 22:17:25 INFO - PROCESS | 22539 | 22:20:27 INFO - PROCESS | 22539 | Cycle 1(1): loaded http://localhost:58153/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58153/tests/dromaeo/cssquery-prototype.html) 22:20:28 INFO - PROCESS | 22539 | RSS: Main: 236093440 22:20:28 INFO - PROCESS | 22539 | 22:23:30 INFO - PROCESS | 22539 | Cycle 1(1): loaded http://localhost:58153/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58153/tests/dromaeo/cssquery-yui.html) 22:23:31 INFO - PROCESS | 22539 | RSS: Main: 220319744 22:23:31 INFO - PROCESS | 22539 | 22:26:33 INFO - PROCESS | 22539 | Cycle 1(1): loaded http://localhost:58153/tests/dromaeo/cssquery-yui.html (next: http://localhost:58153/tests/dromaeo/cssquery-dojo.html) 22:26:34 INFO - PROCESS | 22539 | RSS: Main: 267390976 22:26:34 INFO - PROCESS | 22539 | 22:26:34 INFO - PROCESS | 22539 | __start_tp_report 22:26:34 INFO - PROCESS | 22539 | _x_x_mozilla_page_load 22:26:34 INFO - PROCESS | 22539 | _x_x_mozilla_page_load_details 22:26:34 INFO - PROCESS | 22539 | |i|pagename|runs| 22:26:34 INFO - PROCESS | 22539 | |0;dojo.html;3005.969940300597;3061.4336347775647;3095.5047192449197;3101.302207003426;3123.6095488063997;5154.123798954178;5180.6632568883;5193.402758682752;5218.373795144578;5244.082285600024;5135.743212839352;5156.278121063054;5192.350956130484;5206.167013277867;5219.243209734595;4707.152712511746;4728.385309909707;4741.359916411292;4770.475701386556;4904.901901961958;4820.325154478376;4829.661923665345;4851;4873.34209881665;4892.608591312704;4637.165310244155;4651.511591282901;4683.648726345521;4717.386739723814;4795.304680821278;4747.169245382079;4758.381410416659;4761.595264402496;4766.523347665206;4789.928151077736;4612.746298953556;4732.43210814701;4732.881677958044;4742.051589682077;4798.7840547175465;5137.5633071188995;5175.715335656538;5176.352955880515;5184.948150518484;5222.3472065991755;5447.101228297326;5449.482299181611;5470.124780035176;5472.972635136799;5512.972435137799;5428.91856622147;5505.532029777473;5508;5523.143912693539;5569.944300556983;5095.082885080684;5111.846644600668;5114.64197506171;5128.435872054071;5164.044651739403;5520.723963801794;5526.613137080366;5531.502164805187;5531.529819965268;5588.888222235532;5265.947340526545;5337.199420087018;5394.514493695587;5458;5477.123660214346;5496.80761173357;5525.281713377316;5528.778848846082;5529.115341545334;5536.501714845684;5501.779928802803;5505.6696598204235;5512.5589952803675;5519.254900588369;5567.888642227133;5364.356277246756;5383.246345511631;5426.240326354314;5427.185922111715;5476.17857321397;4195.077083041726;4195.559466256061;4201.873943781691;4203.390508376268;4237.788110594458;3716.0709822544363;3727.0309719473134;3783.8675646352244;3807.3527500325013;3823.2162406706557;5240.34495688039;5325.4940780625775;5329.7068661224;5336.946630533723;5345.412004679482;5523.530499907552;5554.833354999357;5558.027345214652;5560.7219639017885;5563.082091454865;5179.430262671103;5225.921611175835;5231.607629427808;5238.659487133325;5289.259503669489;4700.106979673851;4805.37530121082;4854.902901941941;4874.683145595596;4892.877678058077;5697.658140511582;5700.8859822803315;5723.656580605177;5730.398308177581;5732.226149469851;5421.891562168656;5561.944380556142;5577.8047768327915;5588.469095435927;5639.943600564106;5660.603757736919;5671.092625179951;5691.089425691869;5711.286089238845;5743.167240749985;5417.945820541901;5418.945810541844;5424.810131645373;5426.945730542802;5433.538149257357;5467.425920278313;5509.531689806411;5521.4478552144465;5538.030844602098;5567.610267281251;5325.387580428145;5327.840164795062;5337.146056630921;5341.813036543703;5376.166694162411;5292.497212764782;5318.361796584435;5324.8136315228785;5331.866703332447;5366.034113859543;5238.345206849144;5241.816536421207;5242.449542798104;5376.677399356051;5437.809676661298;5366.436524165063;5383.973080134574;5390.164524498709;5406.594505412031;5444.673319600836;5232.607554433356;5275.973620131875;5285.867853303698;5286.524212820865;5343.278657381204 22:26:34 INFO - PROCESS | 22539 | |1;ext.html;598.5361344957657;614.6680792372119;640.51320996043;644.7614382678408;655.7803135949459;31487.842560787194;37264;38289.80855095728;38337.616623833754;38524.61475385242;40418.59581404185;41015;41220;41295.58704412963;41304.17391652165;7764.18476060014;8331.375146863978;8664.913350866475;8679.349048821363;9870.60517579296;9995.750106247366;10174.338667986594;10177.08406243438;10178.18574514037;10181.440020798853;10110.494475276208;10221.23340749443;10222.48887555623;10223.335483193607;10227.897721022806;7921.920780792205;9921.950390248076;10261.230407719377;10611.151107911426;10627.096696780784;10134.13859821916;10202.081812636825;10227.94886025565;10234.1300989416;10267.589296428134;36825.63174368249;37202.627973720184;37445;37693.43459848104;37792.62207377919;3567.7145828333933;3596.9100772480897;4045.3325201341745;4123.299039163349;4250.617444430016;31000.53499197514;31762.205944851332;31771.84114079438;31807.84096079505;31863.84068079645;4311.116221174651;4341.39220509129;4437.267850804614;4547.1360441516335;4610.723356598614;292637;293220;293590.53204734053;293883;293956;58139.4186058134;58543.41456585465;58592.414075859546;58627.70686146542;58959.41040589625;62627.37372626307;62855.37144628587;62911;63182.68408657928;63198.68400657967;16762.74855877163;17042.829571704373;17110.315587376615;17113.914430428016;17130.571735706457;9967.501624918725;11351.262167959056;11763.411829408495;11766.705832354259;11771.293722376684;17441.65116697659;17581;17634.735478967825;17709.38017169393;18373.632527349644;6434.903476447857;6612.305707900698;6649.833754156088;6723.462123030145;6800.217974932847;1027.9229057820694;1033.49358814182;1036.1814166808288;1039.4512176856429;1043.5911519448684;34635.653643463746;35181.648183517835;35338.29323413517;35667.64332356643;35873;1139.1911742662803;1152.6196355202762;1192.1714408486018;1246.1028059796931;1255.8806913343217;14774.63063423423;15570.9221453892;15580.143092129814;15709.293081811345;15982.600434988986;420700;437446.44258795364;438559;440304;441189;57249;59092.704536477046;59212;59287.70356148192;59363;1229.489761748882;1287.1247551664958;1302.1405872124353;1374.4639590559689;1429.1496559547054;29821.10536683903;30950.380992379574;31533.526997094603;33519.16202094967;34173.65826341705;49483;50422;50662.2400663983;50676.49323506718;50785.492145078075;362604;363804;364253;364513;364918;36983.815080924425;43639.56360436482;43687.78156109199;44168;44541.777291113336;43587.78206108949;48240.758796205795;48299.75850120727;48978.26532601943;49144.508554915425;38975;39264;39731.60268397279;40205.597944020185;40934;39011.2197756049;39489.40765888571;39812.601873980886;40045.199096017335;40288.3956740655;40791.7960410196;41072;41151;41589.37615935824;41618.375724363555;34128;35585.46621800727;36097.45853812143;36136.4579531302;36396.454053188696;26834.59748103741;27327.86336068307;27336.179914602595;27391.72608273892;27564.310892227855 22:26:34 INFO - PROCESS | 22539 | |2;jquery.html;379.39297124600625;380.5300453939385;381.10820679609714;383.24309488759684;384.2027792330914;17313.983642529416;19533.511662208417;19743.901280493596;19837.40487785367;19853.205871765113;18099.90950045248;18387.816121838812;18729.25082996682;18883.811161888378;18924.526886827836;5502.779888804453;5584.664920104807;5636.943630563683;5672.035753921843;5672.602917795756;5452.40023597404;5633.690147041911;5655.0386434306065;5660.858478538028;5662.5753068520025;4992.650514463989;5605.075162598187;5610.270664813568;5612.803551875685;5617.045102332593;5298.311219541473;5300.310959575269;5321.813736519242;5326.387465441485;5330.733463326837;5028.145215313405;5167.870803229912;5172.120739474299;5172.793088276464;5305.442928492491;12244.571439999647;12314.26114433128;12409.255444673348;12413.44139513724;13255.536056238081;2143.1692686608703;2173.0655817998254;2177.9564408711894;2279.6352583586545;2349.01341436597;8923.15230053144;9052.547372631341;9207.40151890125;9306.813863722688;9540.236781057498;1853.9907300463412;1955.5697746495748;1963.803619638039;1968.5177131602707;2018.777934427212;51675.74162129203;64597.67701161511;65275;71359;76250;9423.717288481357;9481.573329200202;9678.886473248842;9812.165965892978;9890.653827116017;11842.348670823016;13207.141535800334;13220.206787592775;13250.668733281746;13255.204687718768;7635.198304178092;7908.920910790818;7927.365810735243;8065.112837587861;8066.838663226703;7729.3043626072795;7769.72805951789;7870.72452464161;7940.682372705142;7956.085050219183;4367.213901497697;4406.449193850769;4651.906961860812;4701.036287561042;4718.598919091847;1738.1396208876688;1894.2707057782852;1897.1273214321566;1948.9415317540497;1948.990255048744;897.6499165325529;959.1559427703716;1036.3212096077082;1056.7410984308895;1095.1950316517352;17824.821751782576;18363.35728249505;18603.90698046501;18668.906655466635;18741.34405295808;1024.784795193003;1027.3014350241758;1048.3238311289176;1079.4171147580219;1082.0477979378097;10129.594816207416;10487.842682359771;10604.94697526523;10605.045545900752;10628;482561;487908.3300836905;495857;498550;503925;86901.56549217213;87606.56196718976;87907.56046219727;89033;89215;996.3922007575374;1011.2819897872446;1015.669907280137;1016.8017236638784;1045.534737042009;15913.283902224659;16052.357905683642;16302.266398012354;16346.182690865648;16369.263383148025;35937.46093808542;36070.8196459016;36511.81744091262;36561.81719091388;37592.2481550362;47875.28187077266;51530.742346288025;53249.73375133255;53490.46509534855;54516.727416362664;7790.1041380241995;7909.485883417559;7939.126696063544;8034.758957231293;8199.42604017713;11656.30062196271;13112.934435327763;13200.273984930922;13247.80128298057;13290.534831280858;5752.108423194411;8684.956575217337;11309.547618095185;11441.48513316886;11989.460474278503;11186.88813111891;11495.195336326376;11521.423928803359;11636.767264654829;11884.584039558575;11415.143864210384;11722.58970936013;11770.3526306054;11800.645980620595;12028.398580071136;7918.326942209746;7969.72105976288;8049.114597394399;8063.798405039921;8700.390972631854;10952.452377381258;11282.661520154408;11458.713532161762;11869.643910682693;11944.343061131374 22:26:34 INFO - PROCESS | 22539 | |3;mootools.html;1363.8977076719248;1466.4867296446241;1499.2353899511247;1623.7807895934052;1769.8230176982295;7805.375569954404;8101.270885620293;8101.270885620293;8109.959450202756;8112.310453611442;7906.723264685737;8029.799255018613;8030.91969080309;8039.356851451885;8042.959785201066;1920.395075551197;2154.1598776477185;2197.6264035114027;2224.1103558576538;2225.766294539066;2272.2728726807427;2276.6243569810963;2289.9656505152434;2292.2206449807063;2295.3228797504694;2218.556288742258;2243.8204943604555;2249.403907964391;2249.932502024934;2250.3473992542145;1944.0959953621564;2144.7211862457857;2207.6798864164766;2208.149862303009;2212.5021870079186;2087.3946555498887;2096.360610013945;2107.7576078750985;2109.1352545456443;2137.8289736821016;7911.485753426066;7983.600819958979;7987.720429784988;8030.156833532454;8030.996125484315;4842.782074806607;4990.65065445419;4994.975025124888;5031.647784655075;5033.697978121324;3243.3026899216547;3250.236194494292;3288.93422131556;3294.0776582556923;3311.61916379617;1028.5782829040058;1043.7181960870598;1046.5578989255823;1060.067140915989;1064.1858977881927;11399.430028498542;11465.254758440675;11531.94234028833;11540.769184616262;11595;4227.112306415625;4288.828446862153;4394.692371533962;4450.888727781767;4463.107378524243;9705;9719.271054670928;9743.610255589698;9755.756106097262;9787.559559819825;4563.885902852388;5064.645474816801;5070.29015937769;5085.949140508622;5122.078025955364;4450.532694067141;4488.169688607618;4516.345129956204;4525.389072475239;4541.409616749867;3803;3839.347310957144;3935.0359162005493;3951.7628942263555;3968.940465893014;1198.9880101198876;1232.1744431231098;1240.0265791353925;1248.1637303006826;1258.7419578986285;847.6482259862088;980.3284749946167;988.5847943863595;1016.7102375822855;1038.864947556828;5674.716264186774;5689.602774054976;5795.130730390475;5820.650760954356;5827.4172582741385;385.9247446747857;395.7427672013157;396.8115145306014;398.80259271660714;400.38340954929663;4028.194361127786;4030.617091376373;4044.130511939947;4069.593040695907;4209.789510524462;9973.501324933724;10299.279050466395;10411.375317480975;10433.686989390331;10438.843417348746;10197.592096316064;10304.433256170832;10331.12185464229;10332.483375831329;10351.844722329171;7460.626968651546;7681.116671582728;7752.806179845549;7788.493747906368;7802.453828231969;5531.751071201886;5681.403452637579;5741.196232527366;5804.6807425592;5884.293884733859;9317.813643726951;9421.293402994666;9433.245340372616;9488.667896623585;9506.85739713891;9196.172344489029;9427.962924078483;9578.808423831346;9600.567974441026;9618.615255389706;7243.710251589878;7255.165655949633;7381.26187381279;7408.259174082548;7426.92573074284;7933.246341597539;7963.601819909098;8001.159878212937;8038.83922321562;8064.55644939534;7185.784426467214;7213.963930180315;7312.122545294386;7372.410207183305;7517.699292028257;7266.96366518164;7333.156686981066;7339.229380915141;7442.702291908263;7450.254974502506;6738;6765.864682706417;6783.898241526283;6791.185057793096;6791.422729068085;4855.927161092657;5014.52362025607;5083.593312534915;5134;5153.948460515347;4988.42633097184;5099;5139.049275883974;5173.81891633791;5198.4801519847715 22:26:34 INFO - PROCESS | 22539 | |4;prototype.html;300.2508740691974;302.47218603536834;302.9530422784468;305.1014761527303;307.1246946203319;5745.942540574598;5783.884322313551;5789;5807.535397168227;5830.183774271605;5699.116636921273;5709.828705138842;5710.114932185518;5726.255586773714;5734.455226753462;4152.792360381984;4159.875203743893;4360.847370342039;4374.628156606692;4376.627986621141;4318.157959197958;4341.088371442001;4343.370211319372;4347.087111706545;4351.456067991501;4041.5352234493116;4326.891827704301;4336.132773445308;4336.633960302511;4339.7396156230725;4156.459660244179;4313.352997050436;4318.82724691012;4353.0858519711055;4359.280718681413;3736.271427071722;3741.307858046243;3744.756590821588;3759.6240375962184;3765.265773174232;5379.865503362447;5455.954017243534;5469.15228139635;5480.534154596864;5484.095124304485;4976.87557811054;4979.900401991976;5000.649954503187;5019.698818070891;5025.6733312334945;5887.322957859816;5933.910991335133;5940.524758019391;5945;5954.374790647006;4060.979695101535;4092.877213683594;4155.459790227251;4157.89815698837;4163.791810409467;6250.531210159256;6259.749610015594;6266.655333956631;6274.341194174637;6280.842978925563;4262.552431994658;4268.189044081614;4273.995611031405;4275;4284.10033892886;3974.2250261198787;4316.913661726748;4325.243082460557;4328.458942632171;4330.069035157457;4903.215485522299;4929.112759703216;4934.333864928189;4943.431505376856;4949.678270912379;6032.155498230251;6040.577159598786;6040.879182416327;6043.8186854394435;6047.304559975659;1412.971740565183;1436.2244388030347;1450.8839292856546;1454.527278634448;1464.0629996802056;848.6775025490274;934.4907025671025;939.8496240601607;958.8513780364054;963.1764841060932;5767.394423585463;5779.682117483495;5796.536277097822;5798.768049277982;5799.82600521985;6163;6166.630002199882;6175.752969881154;6191.752329906843;6205.906911396332;5585.273914391103;5823.359430462646;5924.4667979882015;5931.466168044896;5941.851453713605;3331.3170799985946;3346.6486018968144;3347.2134048498583;3347.292880630847;3354.4297469430257;6265.96867015662;6446.258680251831;6460.773872914519;6463.4506066983895;6476.740930362827;6328.905066424008;6354.650494222769;6378.17083779115;6408.654182621608;6446.613203207822;6119.938800611937;6435.74257029723;6438.645874476855;6442.710078046499;6447.516436267205;6261.5616906816085;6299.905501417391;6301.684915754102;6307.873842523216;6321.51444410554;6166.969165154325;6203;6222.751089956532;6223.284322302993;6234.407731265523;6304.936950630435;6508.772192973223;6521.011091616912;6526;6529.412352888263;4104.466419365583;4164.958350416457;4184.937225941674;4186.1418409225425;4207.758711180148;6190.659513726789;6260.906086408617;6300.117983482408;6314.810555683337;6323.146375239284;6044.516438684983;6076.210092687922;6078.787242446493;6093.390660933871;6097.847553811191;6035.849103772441;6046.2139921809885;6050.45545900871;6054.3340232575265;6057.303410107894;5737.139429085671;5739.149374307059;5866.384029676822;5906.616069955439;5994.130851026664;6072.696365181635;6088.4824789893355;6096.786612468542;6107.206063211754;6110.847228819315;5678.716064196691;5941.287045554561;5942.851428714317;5950.72059507208;5955.612885162451 22:26:34 INFO - PROCESS | 22539 | |5;yui.html;816.852966466036;836.8159005018902;841.9747407577768;851.9531425771584;877.9912200877991;14093.57719268421;14456.638584035405;14459.638509037266;14484.855151448483;14486.999999999987;13631.659208519768;13724.176549407042;14226.217558034305;14259.714805703905;14263.572092837205;680.2823021712092;803.5178892664413;811.0956283743642;815.5106935838479;817.15832692327;792.1563534835382;821.1788211788212;825.1707034430419;825.7852958230873;826.182079741058;858.841114393836;859.4843094143527;860.9956950215271;861.3755027604999;862.9352798540103;706.5725236232108;723.9167495738005;846.8645016797313;850.5109562001843;852.6759831264142;532.6324835863242;606.5420607441398;625.3715016408526;629.5184184099168;629.559308484063;14507.637309067251;14531.491397801026;14536.127832329988;14582.4896128635;14633.048851824597;14183.290835458289;14503;14570.854291457055;14703.19132447715;14724;10294.227932905062;10347.120494757955;10373.118284945713;10408.47957602117;10462.843057354146;3674.9448758268645;3755.906102347436;3781.149241420686;3802.239552089593;3839.7120215983914;53731.731341343046;54092.72953635207;54515.72742136304;54555;54574.18138727922;9670.178034866974;9916.543450000434;9948.552315145836;10151.1371533419;10372.066514013775;20231.595368092556;20240.392788216082;20273.49316267105;20281.79718202799;20281.898590506953;7789.961050194713;7920.247576480225;8072.192780721881;8094.109647938722;8127.471714338549;4246.150769846043;4421.602055814992;4436.0240747035605;4511.481179664315;4556.589906908394;3010.969890301069;3073.2163298359224;3073.8770449181784;3078.6767389424235;3082.05997170865;571.5427657873685;577.8093229234343;577.9971100144472;582.5776312173725;590.6101972697999;597.4354235247649;677.617146312332;681.4888833374969;682.8975653651992;702.2906864067329;8349.33205343571;8698.086700896441;8881.200691937756;8947.628878347243;8966.551672416483;620.2371083567148;635.9554831161867;671.4427025568766;672.5426709837358;679.0154276299386;3977.9204415911518;4021.416894550274;4052.392141178788;4088.3049881520215;4220.07158425146;54557.72721136369;56438.71780641071;56524;64773;65275.67362163159;52499.47500525022;53635.19547206795;53734.46265537295;54215.662746980146;54923.176152357744;47888.760556197696;48153.5184648149;48239.75880120577;49435.75282123566;50052.74973625181;8677.088905664814;8891.73324800257;8896.199342059246;9086.273098152264;9274.165325120772;32856.50715239225;33828.3234335307;34365.484517731755;34554.481682774276;34986.12534686653;43515;47827.76086119547;48360.7581962102;48496;48855;10747.140228781835;11053.668389948314;11074.723131921766;11413.144014199135;11447.427628618703;12462.501499940263;12582.622521324374;12591;12665.240085594894;12949.223046617233;9143.268538517035;11243;11495.655130346104;11636.94181529087;12082.939585302018;11506.194566380607;11546.538138474367;11634.185607007767;11731.706707332385;11760.76478470443;11567.305961642329;11633.53465861356;11707.121965852424;11709.494306012566;11938.761224775282;9187;9597.23222142241;9695.22438204956;9793.363431376938;9807.313488056054;10082.495875206358;10115.140213081677;10179.338343007681;10222.6422075227;10332 22:26:34 INFO - PROCESS | 22539 | __end_tp_report 22:26:34 INFO - PROCESS | 22539 | __start_cc_report 22:26:34 INFO - PROCESS | 22539 | _x_x_mozilla_cycle_collect,843 22:26:34 INFO - PROCESS | 22539 | __end_cc_report 22:26:34 INFO - PROCESS | 22539 | __startTimestamp1461216394166__endTimestamp 22:26:34 INFO - PROCESS | 22539 | 22:26:34 INFO - PROCESS | 22539 | ------- Summary: start ------- 22:26:34 INFO - PROCESS | 22539 | Number of tests: 6 22:26:34 INFO - PROCESS | 22539 | 22:26:34 INFO - PROCESS | 22539 | [#0] dojo.html Cycles:165 Average:5133.71 Median:5325.39 stddev:556.64 (10.5%) stddev-sans-first:532.73 22:26:34 INFO - PROCESS | 22539 | Values: 3006.0 3061.4 3095.5 3101.3 3123.6 5154.1 5180.7 5193.4 5218.4 5244.1 5135.7 5156.3 5192.4 5206.2 5219.2 4707.2 4728.4 4741.4 4770.5 4904.9 4820.3 4829.7 4851.0 4873.3 4892.6 4637.2 4651.5 4683.6 4717.4 4795.3 4747.2 4758.4 4761.6 4766.5 4789.9 4612.7 4732.4 4732.9 4742.1 4798.8 5137.6 5175.7 5176.4 5184.9 5222.3 5447.1 5449.5 5470.1 5473.0 5513.0 5428.9 5505.5 5508.0 5523.1 5569.9 5095.1 5111.8 5114.6 5128.4 5164.0 5520.7 5526.6 5531.5 5531.5 5588.9 5265.9 5337.2 5394.5 5458.0 5477.1 5496.8 5525.3 5528.8 5529.1 5536.5 5501.8 5505.7 5512.6 5519.3 5567.9 5364.4 5383.2 5426.2 5427.2 5476.2 4195.1 4195.6 4201.9 4203.4 4237.8 3716.1 3727.0 3783.9 3807.4 3823.2 5240.3 5325.5 5329.7 5336.9 5345.4 5523.5 5554.8 5558.0 5560.7 5563.1 5179.4 5225.9 5231.6 5238.7 5289.3 4700.1 4805.4 4854.9 4874.7 4892.9 5697.7 5700.9 5723.7 5730.4 5732.2 5421.9 5561.9 5577.8 5588.5 5639.9 5660.6 5671.1 5691.1 5711.3 5743.2 5417.9 5418.9 5424.8 5426.9 5433.5 5467.4 5509.5 5521.4 5538.0 5567.6 5325.4 5327.8 5337.1 5341.8 5376.2 5292.5 5318.4 5324.8 5331.9 5366.0 5238.3 5241.8 5242.4 5376.7 5437.8 5366.4 5384.0 5390.2 5406.6 5444.7 5232.6 5276.0 5285.9 5286.5 5343.3 22:26:34 INFO - PROCESS | 22539 | 22:26:34 INFO - PROCESS | 22539 | [#1] ext.html Cycles:180 Average:53944.89 Median:37093.22 stddev:97073.04 (261.7%) stddev-sans-first:97262.72 22:26:34 INFO - PROCESS | 22539 | Values: 598.5 614.7 640.5 644.8 655.8 31487.8 37264.0 38289.8 38337.6 38524.6 40418.6 41015.0 41220.0 41295.6 41304.2 7764.2 8331.4 8664.9 8679.3 9870.6 9995.8 10174.3 10177.1 10178.2 10181.4 10110.5 10221.2 10222.5 10223.3 10227.9 7921.9 9922.0 10261.2 10611.2 10627.1 10134.1 10202.1 10227.9 10234.1 10267.6 36825.6 37202.6 37445.0 37693.4 37792.6 3567.7 3596.9 4045.3 4123.3 4250.6 31000.5 31762.2 31771.8 31807.8 31863.8 4311.1 4341.4 4437.3 4547.1 4610.7 292637.0 293220.0 293590.5 293883.0 293956.0 58139.4 58543.4 58592.4 58627.7 58959.4 62627.4 62855.4 62911.0 63182.7 63198.7 16762.7 17042.8 17110.3 17113.9 17130.6 9967.5 11351.3 11763.4 11766.7 11771.3 17441.7 17581.0 17634.7 17709.4 18373.6 6434.9 6612.3 6649.8 6723.5 6800.2 1027.9 1033.5 1036.2 1039.5 1043.6 34635.7 35181.6 35338.3 35667.6 35873.0 1139.2 1152.6 1192.2 1246.1 1255.9 14774.6 15570.9 15580.1 15709.3 15982.6 420700.0 437446.4 438559.0 440304.0 441189.0 57249.0 59092.7 59212.0 59287.7 59363.0 1229.5 1287.1 1302.1 1374.5 1429.1 29821.1 30950.4 31533.5 33519.2 34173.7 49483.0 50422.0 50662.2 50676.5 50785.5 362604.0 363804.0 364253.0 364513.0 364918.0 36983.8 43639.6 43687.8 44168.0 44541.8 43587.8 48240.8 48299.8 48978.3 49144.5 38975.0 39264.0 39731.6 40205.6 40934.0 39011.2 39489.4 39812.6 40045.2 40288.4 40791.8 41072.0 41151.0 41589.4 41618.4 34128.0 35585.5 36097.5 36136.5 36396.5 26834.6 27327.9 27336.2 27391.7 27564.3 22:26:34 INFO - PROCESS | 22539 | 22:26:34 INFO - PROCESS | 22539 | [#2] jquery.html Cycles:180 Average:27623.28 Median:379.96 stddev:81134.10 (21353.2%) stddev-sans-first:81335.91 22:26:34 INFO - PROCESS | 22539 | Values: 379.4 380.5 381.1 383.2 384.2 17314.0 19533.5 19743.9 19837.4 19853.2 18099.9 18387.8 18729.3 18883.8 18924.5 5502.8 5584.7 5636.9 5672.0 5672.6 5452.4 5633.7 5655.0 5660.9 5662.6 4992.7 5605.1 5610.3 5612.8 5617.0 5298.3 5300.3 5321.8 5326.4 5330.7 5028.1 5167.9 5172.1 5172.8 5305.4 12244.6 12314.3 12409.3 12413.4 13255.5 2143.2 2173.1 2178.0 2279.6 2349.0 8923.2 9052.5 9207.4 9306.8 9540.2 1854.0 1955.6 1963.8 1968.5 2018.8 51675.7 64597.7 65275.0 71359.0 76250.0 9423.7 9481.6 9678.9 9812.2 9890.7 11842.3 13207.1 13220.2 13250.7 13255.2 7635.2 7908.9 7927.4 8065.1 8066.8 7729.3 7769.7 7870.7 7940.7 7956.1 4367.2 4406.4 4651.9 4701.0 4718.6 1738.1 1894.3 1897.1 1948.9 1949.0 897.6 959.2 1036.3 1056.7 1095.2 17824.8 18363.4 18603.9 18668.9 18741.3 1024.8 1027.3 1048.3 1079.4 1082.0 10129.6 10487.8 10604.9 10605.0 10628.0 482561.0 487908.3 495857.0 498550.0 503925.0 86901.6 87606.6 87907.6 89033.0 89215.0 996.4 1011.3 1015.7 1016.8 1045.5 15913.3 16052.4 16302.3 16346.2 16369.3 35937.5 36070.8 36511.8 36561.8 37592.2 47875.3 51530.7 53249.7 53490.5 54516.7 7790.1 7909.5 7939.1 8034.8 8199.4 11656.3 13112.9 13200.3 13247.8 13290.5 5752.1 8685.0 11309.5 11441.5 11989.5 11186.9 11495.2 11521.4 11636.8 11884.6 11415.1 11722.6 11770.4 11800.6 12028.4 7918.3 7969.7 8049.1 8063.8 8700.4 10952.5 11282.7 11458.7 11869.6 11944.3 22:26:34 INFO - PROCESS | 22539 | 22:26:34 INFO - PROCESS | 22539 | [#3] mootools.html Cycles:180 Average:5477.53 Median:4992.81 stddev:3089.73 (61.9%) stddev-sans-first:3082.93 22:26:34 INFO - PROCESS | 22539 | Values: 1363.9 1466.5 1499.2 1623.8 1769.8 7805.4 8101.3 8101.3 8110.0 8112.3 7906.7 8029.8 8030.9 8039.4 8043.0 1920.4 2154.2 2197.6 2224.1 2225.8 2272.3 2276.6 2290.0 2292.2 2295.3 2218.6 2243.8 2249.4 2249.9 2250.3 1944.1 2144.7 2207.7 2208.1 2212.5 2087.4 2096.4 2107.8 2109.1 2137.8 7911.5 7983.6 7987.7 8030.2 8031.0 4842.8 4990.7 4995.0 5031.6 5033.7 3243.3 3250.2 3288.9 3294.1 3311.6 1028.6 1043.7 1046.6 1060.1 1064.2 11399.4 11465.3 11531.9 11540.8 11595.0 4227.1 4288.8 4394.7 4450.9 4463.1 9705.0 9719.3 9743.6 9755.8 9787.6 4563.9 5064.6 5070.3 5085.9 5122.1 4450.5 4488.2 4516.3 4525.4 4541.4 3803.0 3839.3 3935.0 3951.8 3968.9 1199.0 1232.2 1240.0 1248.2 1258.7 847.6 980.3 988.6 1016.7 1038.9 5674.7 5689.6 5795.1 5820.7 5827.4 385.9 395.7 396.8 398.8 400.4 4028.2 4030.6 4044.1 4069.6 4209.8 9973.5 10299.3 10411.4 10433.7 10438.8 10197.6 10304.4 10331.1 10332.5 10351.8 7460.6 7681.1 7752.8 7788.5 7802.5 5531.8 5681.4 5741.2 5804.7 5884.3 9317.8 9421.3 9433.2 9488.7 9506.9 9196.2 9428.0 9578.8 9600.6 9618.6 7243.7 7255.2 7381.3 7408.3 7426.9 7933.2 7963.6 8001.2 8038.8 8064.6 7185.8 7214.0 7312.1 7372.4 7517.7 7267.0 7333.2 7339.2 7442.7 7450.3 6738.0 6765.9 6783.9 6791.2 6791.4 4855.9 5014.5 5083.6 5134.0 5153.9 4988.4 5099.0 5139.0 5173.8 5198.5 22:26:34 INFO - PROCESS | 22539 | 22:26:34 INFO - PROCESS | 22539 | [#4] prototype.html Cycles:180 Average:5032.00 Median:5799.30 stddev:1546.17 (26.7%) stddev-sans-first:1509.17 22:26:34 INFO - PROCESS | 22539 | Values: 300.3 302.5 303.0 305.1 307.1 5745.9 5783.9 5789.0 5807.5 5830.2 5699.1 5709.8 5710.1 5726.3 5734.5 4152.8 4159.9 4360.8 4374.6 4376.6 4318.2 4341.1 4343.4 4347.1 4351.5 4041.5 4326.9 4336.1 4336.6 4339.7 4156.5 4313.4 4318.8 4353.1 4359.3 3736.3 3741.3 3744.8 3759.6 3765.3 5379.9 5456.0 5469.2 5480.5 5484.1 4976.9 4979.9 5000.6 5019.7 5025.7 5887.3 5933.9 5940.5 5945.0 5954.4 4061.0 4092.9 4155.5 4157.9 4163.8 6250.5 6259.7 6266.7 6274.3 6280.8 4262.6 4268.2 4274.0 4275.0 4284.1 3974.2 4316.9 4325.2 4328.5 4330.1 4903.2 4929.1 4934.3 4943.4 4949.7 6032.2 6040.6 6040.9 6043.8 6047.3 1413.0 1436.2 1450.9 1454.5 1464.1 848.7 934.5 939.8 958.9 963.2 5767.4 5779.7 5796.5 5798.8 5799.8 6163.0 6166.6 6175.8 6191.8 6205.9 5585.3 5823.4 5924.5 5931.5 5941.9 3331.3 3346.6 3347.2 3347.3 3354.4 6266.0 6446.3 6460.8 6463.5 6476.7 6328.9 6354.7 6378.2 6408.7 6446.6 6119.9 6435.7 6438.6 6442.7 6447.5 6261.6 6299.9 6301.7 6307.9 6321.5 6167.0 6203.0 6222.8 6223.3 6234.4 6304.9 6508.8 6521.0 6526.0 6529.4 4104.5 4165.0 4184.9 4186.1 4207.8 6190.7 6260.9 6300.1 6314.8 6323.1 6044.5 6076.2 6078.8 6093.4 6097.8 6035.8 6046.2 6050.5 6054.3 6057.3 5737.1 5739.1 5866.4 5906.6 5994.1 6072.7 6088.5 6096.8 6107.2 6110.8 5678.7 5941.3 5942.9 5950.7 5955.6 22:26:34 INFO - PROCESS | 22539 | 22:26:34 INFO - PROCESS | 22539 | [#5] yui.html Cycles:180 Average:14494.80 Median:48300.26 stddev:16917.61 (35.0%) stddev-sans-first:16933.89 22:26:34 INFO - PROCESS | 22539 | Values: 816.9 836.8 842.0 852.0 878.0 14093.6 14456.6 14459.6 14484.9 14487.0 13631.7 13724.2 14226.2 14259.7 14263.6 680.3 803.5 811.1 815.5 817.2 792.2 821.2 825.2 825.8 826.2 858.8 859.5 861.0 861.4 862.9 706.6 723.9 846.9 850.5 852.7 532.6 606.5 625.4 629.5 629.6 14507.6 14531.5 14536.1 14582.5 14633.0 14183.3 14503.0 14570.9 14703.2 14724.0 10294.2 10347.1 10373.1 10408.5 10462.8 3674.9 3755.9 3781.1 3802.2 3839.7 53731.7 54092.7 54515.7 54555.0 54574.2 9670.2 9916.5 9948.6 10151.1 10372.1 20231.6 20240.4 20273.5 20281.8 20281.9 7790.0 7920.2 8072.2 8094.1 8127.5 4246.2 4421.6 4436.0 4511.5 4556.6 3011.0 3073.2 3073.9 3078.7 3082.1 571.5 577.8 578.0 582.6 590.6 597.4 677.6 681.5 682.9 702.3 8349.3 8698.1 8881.2 8947.6 8966.6 620.2 636.0 671.4 672.5 679.0 3977.9 4021.4 4052.4 4088.3 4220.1 54557.7 56438.7 56524.0 64773.0 65275.7 52499.5 53635.2 53734.5 54215.7 54923.2 47888.8 48153.5 48239.8 49435.8 50052.7 8677.1 8891.7 8896.2 9086.3 9274.2 32856.5 33828.3 34365.5 34554.5 34986.1 43515.0 47827.8 48360.8 48496.0 48855.0 10747.1 11053.7 11074.7 11413.1 11447.4 12462.5 12582.6 12591.0 12665.2 12949.2 9143.3 11243.0 11495.7 11636.9 12082.9 11506.2 11546.5 11634.2 11731.7 11760.8 11567.3 11633.5 11707.1 11709.5 11938.8 9187.0 9597.2 9695.2 9793.4 9807.3 10082.5 10115.1 10179.3 10222.6 10332.0 22:26:34 INFO - PROCESS | 22539 | -------- Summary: end -------- 22:26:34 INFO - PROCESS | 22539 | 22:26:34 INFO - TEST-INFO | 22539: exit 0 22:26:34 INFO - TEST-OK | dromaeo_css | took 1111482ms 22:26:34 INFO - TEST-START | kraken 22:26:34 INFO - operating with platform_type : linux_ 22:26:34 INFO - Initialising browser for kraken test... 22:26:34 INFO - TEST-INFO | started process 22721 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy9w8_x/profile http://localhost:58153/getInfo.html) 22:26:38 INFO - PROCESS | 22721 | __metrics Screen width/height:1600/1200 22:26:38 INFO - PROCESS | 22721 | colorDepth:24 22:26:38 INFO - PROCESS | 22721 | Browser inner width/height: 1024/697 22:26:38 INFO - PROCESS | 22721 | __metrics 22:26:39 ERROR - PROCESS | 22721 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:26:40 INFO - TEST-INFO | 22721: exit 0 22:26:40 INFO - Browser initialized. 22:26:40 INFO - Running cycle 1/1 for kraken test... 22:26:40 INFO - TEST-INFO | started process 22801 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy9w8_x/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:26:52 INFO - PROCESS | 22801 | RSS: Main: 153264128 22:26:52 INFO - PROCESS | 22801 | 22:26:54 INFO - PROCESS | 22801 | Cycle 1(1): loaded http://localhost:58153/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58153/tests/kraken/driver.html?testName=audio-beat-detection) 22:26:55 INFO - PROCESS | 22801 | RSS: Main: 208125952 22:26:55 INFO - PROCESS | 22801 | 22:26:58 INFO - PROCESS | 22801 | Cycle 1(1): loaded http://localhost:58153/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58153/tests/kraken/driver.html?testName=audio-dft) 22:26:58 INFO - PROCESS | 22801 | RSS: Main: 193990656 22:26:58 INFO - PROCESS | 22801 | 22:27:02 INFO - PROCESS | 22801 | Cycle 1(1): loaded http://localhost:58153/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58153/tests/kraken/driver.html?testName=audio-fft) 22:27:02 INFO - PROCESS | 22801 | RSS: Main: 263753728 22:27:02 INFO - PROCESS | 22801 | 22:27:04 INFO - PROCESS | 22801 | Cycle 1(1): loaded http://localhost:58153/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58153/tests/kraken/driver.html?testName=audio-oscillator) 22:27:05 INFO - PROCESS | 22801 | RSS: Main: 172904448 22:27:05 INFO - PROCESS | 22801 | 22:27:07 INFO - PROCESS | 22801 | Cycle 1(1): loaded http://localhost:58153/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58153/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:27:08 INFO - PROCESS | 22801 | RSS: Main: 176807936 22:27:08 INFO - PROCESS | 22801 | 22:27:11 INFO - PROCESS | 22801 | Cycle 1(1): loaded http://localhost:58153/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58153/tests/kraken/driver.html?testName=imaging-darkroom) 22:27:11 INFO - PROCESS | 22801 | RSS: Main: 213585920 22:27:11 INFO - PROCESS | 22801 | 22:27:14 INFO - PROCESS | 22801 | Cycle 1(1): loaded http://localhost:58153/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58153/tests/kraken/driver.html?testName=imaging-desaturate) 22:27:15 INFO - PROCESS | 22801 | RSS: Main: 214347776 22:27:15 INFO - PROCESS | 22801 | 22:27:18 INFO - PROCESS | 22801 | Cycle 1(1): loaded http://localhost:58153/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58153/tests/kraken/driver.html?testName=json-parse-financial) 22:27:18 INFO - PROCESS | 22801 | RSS: Main: 213770240 22:27:18 INFO - PROCESS | 22801 | 22:27:20 INFO - PROCESS | 22801 | Cycle 1(1): loaded http://localhost:58153/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58153/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:27:21 INFO - PROCESS | 22801 | RSS: Main: 202293248 22:27:21 INFO - PROCESS | 22801 | 22:27:22 INFO - PROCESS | 22801 | Cycle 1(1): loaded http://localhost:58153/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58153/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:27:23 INFO - PROCESS | 22801 | RSS: Main: 203145216 22:27:23 INFO - PROCESS | 22801 | 22:27:25 INFO - PROCESS | 22801 | Cycle 1(1): loaded http://localhost:58153/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58153/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:27:26 INFO - PROCESS | 22801 | RSS: Main: 217407488 22:27:26 INFO - PROCESS | 22801 | 22:27:28 INFO - PROCESS | 22801 | Cycle 1(1): loaded http://localhost:58153/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58153/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:27:29 INFO - PROCESS | 22801 | RSS: Main: 222412800 22:27:29 INFO - PROCESS | 22801 | 22:27:32 INFO - PROCESS | 22801 | Cycle 1(1): loaded http://localhost:58153/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58153/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:27:32 INFO - PROCESS | 22801 | RSS: Main: 218955776 22:27:32 INFO - PROCESS | 22801 | 22:27:34 INFO - PROCESS | 22801 | Cycle 1(1): loaded http://localhost:58153/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58153/tests/kraken/driver.html?testName=ai-astar) 22:27:34 INFO - PROCESS | 22801 | RSS: Main: 282292224 22:27:34 INFO - PROCESS | 22801 | 22:27:34 INFO - PROCESS | 22801 | __start_tp_report 22:27:34 INFO - PROCESS | 22801 | _x_x_mozilla_page_load 22:27:34 INFO - PROCESS | 22801 | _x_x_mozilla_page_load_details 22:27:34 INFO - PROCESS | 22801 | |i|pagename|runs| 22:27:34 INFO - PROCESS | 22801 | |0;ai-astar;112;113;107;113;114;113;102;113;112;111 22:27:34 INFO - PROCESS | 22801 | |1;audio-beat-detection;151;128;157;180;129;155;155;128;182;126 22:27:34 INFO - PROCESS | 22801 | |2;audio-dft;161;162;161;162;161;160;161;162;160;161 22:27:34 INFO - PROCESS | 22801 | |3;audio-fft;76;76;98;115;78;76;75;131;110;76 22:27:34 INFO - PROCESS | 22801 | |4;audio-oscillator;91;93;155;92;92;92;145;93;92;145 22:27:34 INFO - PROCESS | 22801 | |5;imaging-gaussian-blur;116;117;117;116;116;117;116;117;117;117 22:27:34 INFO - PROCESS | 22801 | |6;imaging-darkroom;146;146;146;145;145;147;146;146;146;146 22:27:34 INFO - PROCESS | 22801 | |7;imaging-desaturate;95;95;95;95;96;94;96;95;95;95 22:27:34 INFO - PROCESS | 22801 | |8;json-parse-financial;56;55;55;55;59;55;57;80;54;51 22:27:34 INFO - PROCESS | 22801 | |9;json-stringify-tinderbox;62;61;61;60;61;60;61;61;62;61 22:27:34 INFO - PROCESS | 22801 | |10;stanford-crypto-aes;76;76;75;76;77;77;76;87;78;78 22:27:34 INFO - PROCESS | 22801 | |11;stanford-crypto-ccm;135;130;135;134;122;123;126;123;161;126 22:27:34 INFO - PROCESS | 22801 | |12;stanford-crypto-pbkdf2;167;162;169;164;165;164;163;162;167;166 22:27:34 INFO - PROCESS | 22801 | |13;stanford-crypto-sha256-iterative;69;68;67;68;69;68;67;67;68;68 22:27:34 INFO - PROCESS | 22801 | __end_tp_report 22:27:34 INFO - PROCESS | 22801 | __start_cc_report 22:27:34 INFO - PROCESS | 22801 | _x_x_mozilla_cycle_collect,1637 22:27:34 INFO - PROCESS | 22801 | __end_cc_report 22:27:34 INFO - PROCESS | 22801 | __startTimestamp1461216454726__endTimestamp 22:27:34 INFO - PROCESS | 22801 | 22:27:34 INFO - PROCESS | 22801 | ------- Summary: start ------- 22:27:34 INFO - PROCESS | 22801 | Number of tests: 14 22:27:34 INFO - PROCESS | 22801 | 22:27:34 INFO - PROCESS | 22801 | [#0] ai-astar Cycles:10 Average:111.00 Median:113.00 stddev:3.71 (3.3%) stddev-sans-first:3.92 22:27:34 INFO - PROCESS | 22801 | Values: 112.0 113.0 107.0 113.0 114.0 113.0 102.0 113.0 112.0 111.0 22:27:34 INFO - PROCESS | 22801 | 22:27:34 INFO - PROCESS | 22801 | [#1] audio-beat-detection Cycles:10 Average:149.10 Median:155.00 stddev:21.08 (13.6%) stddev-sans-first:22.35 22:27:34 INFO - PROCESS | 22801 | Values: 151.0 128.0 157.0 180.0 129.0 155.0 155.0 128.0 182.0 126.0 22:27:34 INFO - PROCESS | 22801 | 22:27:34 INFO - PROCESS | 22801 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 22:27:34 INFO - PROCESS | 22801 | Values: 161.0 162.0 161.0 162.0 161.0 160.0 161.0 162.0 160.0 161.0 22:27:34 INFO - PROCESS | 22801 | 22:27:34 INFO - PROCESS | 22801 | [#3] audio-fft Cycles:10 Average:91.10 Median:76.00 stddev:20.85 (27.4%) stddev-sans-first:21.38 22:27:34 INFO - PROCESS | 22801 | Values: 76.0 76.0 98.0 115.0 78.0 76.0 75.0 131.0 110.0 76.0 22:27:34 INFO - PROCESS | 22801 | 22:27:34 INFO - PROCESS | 22801 | [#4] audio-oscillator Cycles:10 Average:109.00 Median:92.00 stddev:27.28 (29.7%) stddev-sans-first:28.15 22:27:34 INFO - PROCESS | 22801 | Values: 91.0 93.0 155.0 92.0 92.0 92.0 145.0 93.0 92.0 145.0 22:27:34 INFO - PROCESS | 22801 | 22:27:34 INFO - PROCESS | 22801 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 22:27:34 INFO - PROCESS | 22801 | Values: 116.0 117.0 117.0 116.0 116.0 117.0 116.0 117.0 117.0 117.0 22:27:34 INFO - PROCESS | 22801 | 22:27:34 INFO - PROCESS | 22801 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 22:27:34 INFO - PROCESS | 22801 | Values: 146.0 146.0 146.0 145.0 145.0 147.0 146.0 146.0 146.0 146.0 22:27:34 INFO - PROCESS | 22801 | 22:27:34 INFO - PROCESS | 22801 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 22:27:34 INFO - PROCESS | 22801 | Values: 95.0 95.0 95.0 95.0 96.0 94.0 96.0 95.0 95.0 95.0 22:27:34 INFO - PROCESS | 22801 | 22:27:34 INFO - PROCESS | 22801 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:55.50 stddev:8.10 (14.6%) stddev-sans-first:8.57 22:27:34 INFO - PROCESS | 22801 | Values: 56.0 55.0 55.0 55.0 59.0 55.0 57.0 80.0 54.0 51.0 22:27:34 INFO - PROCESS | 22801 | 22:27:34 INFO - PROCESS | 22801 | [#9] json-stringify-tinderbox Cycles:10 Average:61.00 Median:61.00 stddev:0.67 (1.1%) stddev-sans-first:0.60 22:27:34 INFO - PROCESS | 22801 | Values: 62.0 61.0 61.0 60.0 61.0 60.0 61.0 61.0 62.0 61.0 22:27:34 INFO - PROCESS | 22801 | 22:27:34 INFO - PROCESS | 22801 | [#10] stanford-crypto-aes Cycles:10 Average:77.60 Median:77.00 stddev:3.44 (4.5%) stddev-sans-first:3.60 22:27:34 INFO - PROCESS | 22801 | Values: 76.0 76.0 75.0 76.0 77.0 77.0 76.0 87.0 78.0 78.0 22:27:34 INFO - PROCESS | 22801 | 22:27:34 INFO - PROCESS | 22801 | [#11] stanford-crypto-ccm Cycles:10 Average:131.50 Median:132.00 stddev:11.54 (8.7%) stddev-sans-first:12.17 22:27:34 INFO - PROCESS | 22801 | Values: 135.0 130.0 135.0 134.0 122.0 123.0 126.0 123.0 161.0 126.0 22:27:34 INFO - PROCESS | 22801 | 22:27:34 INFO - PROCESS | 22801 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.90 Median:165.50 stddev:2.33 (1.4%) stddev-sans-first:2.35 22:27:34 INFO - PROCESS | 22801 | Values: 167.0 162.0 169.0 164.0 165.0 164.0 163.0 162.0 167.0 166.0 22:27:34 INFO - PROCESS | 22801 | 22:27:34 INFO - PROCESS | 22801 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:0.74 (1.1%) stddev-sans-first:0.67 22:27:34 INFO - PROCESS | 22801 | Values: 69.0 68.0 67.0 68.0 69.0 68.0 67.0 67.0 68.0 68.0 22:27:34 INFO - PROCESS | 22801 | -------- Summary: end -------- 22:27:34 INFO - PROCESS | 22801 | 22:27:35 INFO - TEST-INFO | 22801: exit 0 22:27:35 INFO - TEST-OK | kraken | took 60814ms 22:27:35 INFO - SUITE-END | took 1172s 22:27:35 INFO - Completed test suite (00:19:32) 22:27:35 INFO - javascript benchmark 22:27:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3005.969940300597, 3061.4336347775647, 3095.5047192449197, 3101.302207003426, 3123.6095488063997, 5154.123798954178, 5180.6632568883, 5193.402758682752, 5218.373795144578, 5244.082285600024, 5135.743212839352, 5156.278121063054, 5192.350956130484, 5206.167013277867, 5219.243209734595, 4707.152712511746, 4728.385309909707, 4741.359916411292, 4770.475701386556, 4904.901901961958, 4820.325154478376, 4829.661923665345, 4851.0, 4873.34209881665, 4892.608591312704, 4637.165310244155, 4651.511591282901, 4683.648726345521, 4717.386739723814, 4795.304680821278, 4747.169245382079, 4758.381410416659, 4761.595264402496, 4766.523347665206, 4789.928151077736, 4612.746298953556, 4732.43210814701, 4732.881677958044, 4742.051589682077, 4798.7840547175465, 5137.5633071188995, 5175.715335656538, 5176.352955880515, 5184.948150518484, 5222.3472065991755, 5447.101228297326, 5449.482299181611, 5470.124780035176, 5472.972635136799, 5512.972435137799, 5428.91856622147, 5505.532029777473, 5508.0, 5523.143912693539, 5569.944300556983, 5095.082885080684, 5111.846644600668, 5114.64197506171, 5128.435872054071, 5164.044651739403, 5520.723963801794, 5526.613137080366, 5531.502164805187, 5531.529819965268, 5588.888222235532, 5265.947340526545, 5337.199420087018, 5394.514493695587, 5458.0, 5477.123660214346, 5496.80761173357, 5525.281713377316, 5528.778848846082, 5529.115341545334, 5536.501714845684, 5501.779928802803, 5505.6696598204235, 5512.5589952803675, 5519.254900588369, 5567.888642227133, 5364.356277246756, 5383.246345511631, 5426.240326354314, 5427.185922111715, 5476.17857321397, 4195.077083041726, 4195.559466256061, 4201.873943781691, 4203.390508376268, 4237.788110594458, 3716.0709822544363, 3727.0309719473134, 3783.8675646352244, 3807.3527500325013, 3823.2162406706557, 5240.34495688039, 5325.4940780625775, 5329.7068661224, 5336.946630533723, 5345.412004679482, 5523.530499907552, 5554.833354999357, 5558.027345214652, 5560.7219639017885, 5563.082091454865, 5179.430262671103, 5225.921611175835, 5231.607629427808, 5238.659487133325, 5289.259503669489, 4700.106979673851, 4805.37530121082, 4854.902901941941, 4874.683145595596, 4892.877678058077, 5697.658140511582, 5700.8859822803315, 5723.656580605177, 5730.398308177581, 5732.226149469851, 5421.891562168656, 5561.944380556142, 5577.8047768327915, 5588.469095435927, 5639.943600564106, 5660.603757736919, 5671.092625179951, 5691.089425691869, 5711.286089238845, 5743.167240749985, 5417.945820541901, 5418.945810541844, 5424.810131645373, 5426.945730542802, 5433.538149257357, 5467.425920278313, 5509.531689806411, 5521.4478552144465, 5538.030844602098, 5567.610267281251, 5325.387580428145, 5327.840164795062, 5337.146056630921, 5341.813036543703, 5376.166694162411, 5292.497212764782, 5318.361796584435, 5324.8136315228785, 5331.866703332447, 5366.034113859543, 5238.345206849144, 5241.816536421207, 5242.449542798104, 5376.677399356051, 5437.809676661298, 5366.436524165063, 5383.973080134574, 5390.164524498709, 5406.594505412031, 5444.673319600836, 5232.607554433356, 5275.973620131875, 5285.867853303698, 5286.524212820865, 5343.278657381204], "value": 5097.861738729607, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [598.5361344957657, 614.6680792372119, 640.51320996043, 644.7614382678408, 655.7803135949459, 31487.842560787194, 37264.0, 38289.80855095728, 38337.616623833754, 38524.61475385242, 40418.59581404185, 41015.0, 41220.0, 41295.58704412963, 41304.17391652165, 7764.18476060014, 8331.375146863978, 8664.913350866475, 8679.349048821363, 9870.60517579296, 9995.750106247366, 10174.338667986594, 10177.08406243438, 10178.18574514037, 10181.440020798853, 10110.494475276208, 10221.23340749443, 10222.48887555623, 10223.335483193607, 10227.897721022806, 7921.920780792205, 9921.950390248076, 10261.230407719377, 10611.151107911426, 10627.096696780784, 10134.13859821916, 10202.081812636825, 10227.94886025565, 10234.1300989416, 10267.589296428134, 36825.63174368249, 37202.627973720184, 37445.0, 37693.43459848104, 37792.62207377919, 3567.7145828333933, 3596.9100772480897, 4045.3325201341745, 4123.299039163349, 4250.617444430016, 31000.53499197514, 31762.205944851332, 31771.84114079438, 31807.84096079505, 31863.84068079645, 4311.116221174651, 4341.39220509129, 4437.267850804614, 4547.1360441516335, 4610.723356598614, 292637.0, 293220.0, 293590.53204734053, 293883.0, 293956.0, 58139.4186058134, 58543.41456585465, 58592.414075859546, 58627.70686146542, 58959.41040589625, 62627.37372626307, 62855.37144628587, 62911.0, 63182.68408657928, 63198.68400657967, 16762.74855877163, 17042.829571704373, 17110.315587376615, 17113.914430428016, 17130.571735706457, 9967.501624918725, 11351.262167959056, 11763.411829408495, 11766.705832354259, 11771.293722376684, 17441.65116697659, 17581.0, 17634.735478967825, 17709.38017169393, 18373.632527349644, 6434.903476447857, 6612.305707900698, 6649.833754156088, 6723.462123030145, 6800.217974932847, 1027.9229057820694, 1033.49358814182, 1036.1814166808288, 1039.4512176856429, 1043.5911519448684, 34635.653643463746, 35181.648183517835, 35338.29323413517, 35667.64332356643, 35873.0, 1139.1911742662803, 1152.6196355202762, 1192.1714408486018, 1246.1028059796931, 1255.8806913343217, 14774.63063423423, 15570.9221453892, 15580.143092129814, 15709.293081811345, 15982.600434988986, 420700.0, 437446.44258795364, 438559.0, 440304.0, 441189.0, 57249.0, 59092.704536477046, 59212.0, 59287.70356148192, 59363.0, 1229.489761748882, 1287.1247551664958, 1302.1405872124353, 1374.4639590559689, 1429.1496559547054, 29821.10536683903, 30950.380992379574, 31533.526997094603, 33519.16202094967, 34173.65826341705, 49483.0, 50422.0, 50662.2400663983, 50676.49323506718, 50785.492145078075, 362604.0, 363804.0, 364253.0, 364513.0, 364918.0, 36983.815080924425, 43639.56360436482, 43687.78156109199, 44168.0, 44541.777291113336, 43587.78206108949, 48240.758796205795, 48299.75850120727, 48978.26532601943, 49144.508554915425, 38975.0, 39264.0, 39731.60268397279, 40205.597944020185, 40934.0, 39011.2197756049, 39489.40765888571, 39812.601873980886, 40045.199096017335, 40288.3956740655, 40791.7960410196, 41072.0, 41151.0, 41589.37615935824, 41618.375724363555, 34128.0, 35585.46621800727, 36097.45853812143, 36136.4579531302, 36396.454053188696, 26834.59748103741, 27327.86336068307, 27336.179914602595, 27391.72608273892, 27564.310892227855], "value": 20061.03533114006, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.39297124600625, 380.5300453939385, 381.10820679609714, 383.24309488759684, 384.2027792330914, 17313.983642529416, 19533.511662208417, 19743.901280493596, 19837.40487785367, 19853.205871765113, 18099.90950045248, 18387.816121838812, 18729.25082996682, 18883.811161888378, 18924.526886827836, 5502.779888804453, 5584.664920104807, 5636.943630563683, 5672.035753921843, 5672.602917795756, 5452.40023597404, 5633.690147041911, 5655.0386434306065, 5660.858478538028, 5662.5753068520025, 4992.650514463989, 5605.075162598187, 5610.270664813568, 5612.803551875685, 5617.045102332593, 5298.311219541473, 5300.310959575269, 5321.813736519242, 5326.387465441485, 5330.733463326837, 5028.145215313405, 5167.870803229912, 5172.120739474299, 5172.793088276464, 5305.442928492491, 12244.571439999647, 12314.26114433128, 12409.255444673348, 12413.44139513724, 13255.536056238081, 2143.1692686608703, 2173.0655817998254, 2177.9564408711894, 2279.6352583586545, 2349.01341436597, 8923.15230053144, 9052.547372631341, 9207.40151890125, 9306.813863722688, 9540.236781057498, 1853.9907300463412, 1955.5697746495748, 1963.803619638039, 1968.5177131602707, 2018.777934427212, 51675.74162129203, 64597.67701161511, 65275.0, 71359.0, 76250.0, 9423.717288481357, 9481.573329200202, 9678.886473248842, 9812.165965892978, 9890.653827116017, 11842.348670823016, 13207.141535800334, 13220.206787592775, 13250.668733281746, 13255.204687718768, 7635.198304178092, 7908.920910790818, 7927.365810735243, 8065.112837587861, 8066.838663226703, 7729.3043626072795, 7769.72805951789, 7870.72452464161, 7940.682372705142, 7956.085050219183, 4367.213901497697, 4406.449193850769, 4651.906961860812, 4701.036287561042, 4718.598919091847, 1738.1396208876688, 1894.2707057782852, 1897.1273214321566, 1948.9415317540497, 1948.990255048744, 897.6499165325529, 959.1559427703716, 1036.3212096077082, 1056.7410984308895, 1095.1950316517352, 17824.821751782576, 18363.35728249505, 18603.90698046501, 18668.906655466635, 18741.34405295808, 1024.784795193003, 1027.3014350241758, 1048.3238311289176, 1079.4171147580219, 1082.0477979378097, 10129.594816207416, 10487.842682359771, 10604.94697526523, 10605.045545900752, 10628.0, 482561.0, 487908.3300836905, 495857.0, 498550.0, 503925.0, 86901.56549217213, 87606.56196718976, 87907.56046219727, 89033.0, 89215.0, 996.3922007575374, 1011.2819897872446, 1015.669907280137, 1016.8017236638784, 1045.534737042009, 15913.283902224659, 16052.357905683642, 16302.266398012354, 16346.182690865648, 16369.263383148025, 35937.46093808542, 36070.8196459016, 36511.81744091262, 36561.81719091388, 37592.2481550362, 47875.28187077266, 51530.742346288025, 53249.73375133255, 53490.46509534855, 54516.727416362664, 7790.1041380241995, 7909.485883417559, 7939.126696063544, 8034.758957231293, 8199.42604017713, 11656.30062196271, 13112.934435327763, 13200.273984930922, 13247.80128298057, 13290.534831280858, 5752.108423194411, 8684.956575217337, 11309.547618095185, 11441.48513316886, 11989.460474278503, 11186.88813111891, 11495.195336326376, 11521.423928803359, 11636.767264654829, 11884.584039558575, 11415.143864210384, 11722.58970936013, 11770.3526306054, 11800.645980620595, 12028.398580071136, 7918.326942209746, 7969.72105976288, 8049.114597394399, 8063.798405039921, 8700.390972631854, 10952.452377381258, 11282.661520154408, 11458.713532161762, 11869.643910682693, 11944.343061131374], "value": 8641.110003239268, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1363.8977076719248, 1466.4867296446241, 1499.2353899511247, 1623.7807895934052, 1769.8230176982295, 7805.375569954404, 8101.270885620293, 8101.270885620293, 8109.959450202756, 8112.310453611442, 7906.723264685737, 8029.799255018613, 8030.91969080309, 8039.356851451885, 8042.959785201066, 1920.395075551197, 2154.1598776477185, 2197.6264035114027, 2224.1103558576538, 2225.766294539066, 2272.2728726807427, 2276.6243569810963, 2289.9656505152434, 2292.2206449807063, 2295.3228797504694, 2218.556288742258, 2243.8204943604555, 2249.403907964391, 2249.932502024934, 2250.3473992542145, 1944.0959953621564, 2144.7211862457857, 2207.6798864164766, 2208.149862303009, 2212.5021870079186, 2087.3946555498887, 2096.360610013945, 2107.7576078750985, 2109.1352545456443, 2137.8289736821016, 7911.485753426066, 7983.600819958979, 7987.720429784988, 8030.156833532454, 8030.996125484315, 4842.782074806607, 4990.65065445419, 4994.975025124888, 5031.647784655075, 5033.697978121324, 3243.3026899216547, 3250.236194494292, 3288.93422131556, 3294.0776582556923, 3311.61916379617, 1028.5782829040058, 1043.7181960870598, 1046.5578989255823, 1060.067140915989, 1064.1858977881927, 11399.430028498542, 11465.254758440675, 11531.94234028833, 11540.769184616262, 11595.0, 4227.112306415625, 4288.828446862153, 4394.692371533962, 4450.888727781767, 4463.107378524243, 9705.0, 9719.271054670928, 9743.610255589698, 9755.756106097262, 9787.559559819825, 4563.885902852388, 5064.645474816801, 5070.29015937769, 5085.949140508622, 5122.078025955364, 4450.532694067141, 4488.169688607618, 4516.345129956204, 4525.389072475239, 4541.409616749867, 3803.0, 3839.347310957144, 3935.0359162005493, 3951.7628942263555, 3968.940465893014, 1198.9880101198876, 1232.1744431231098, 1240.0265791353925, 1248.1637303006826, 1258.7419578986285, 847.6482259862088, 980.3284749946167, 988.5847943863595, 1016.7102375822855, 1038.864947556828, 5674.716264186774, 5689.602774054976, 5795.130730390475, 5820.650760954356, 5827.4172582741385, 385.9247446747857, 395.7427672013157, 396.8115145306014, 398.80259271660714, 400.38340954929663, 4028.194361127786, 4030.617091376373, 4044.130511939947, 4069.593040695907, 4209.789510524462, 9973.501324933724, 10299.279050466395, 10411.375317480975, 10433.686989390331, 10438.843417348746, 10197.592096316064, 10304.433256170832, 10331.12185464229, 10332.483375831329, 10351.844722329171, 7460.626968651546, 7681.116671582728, 7752.806179845549, 7788.493747906368, 7802.453828231969, 5531.751071201886, 5681.403452637579, 5741.196232527366, 5804.6807425592, 5884.293884733859, 9317.813643726951, 9421.293402994666, 9433.245340372616, 9488.667896623585, 9506.85739713891, 9196.172344489029, 9427.962924078483, 9578.808423831346, 9600.567974441026, 9618.615255389706, 7243.710251589878, 7255.165655949633, 7381.26187381279, 7408.259174082548, 7426.92573074284, 7933.246341597539, 7963.601819909098, 8001.159878212937, 8038.83922321562, 8064.55644939534, 7185.784426467214, 7213.963930180315, 7312.122545294386, 7372.410207183305, 7517.699292028257, 7266.96366518164, 7333.156686981066, 7339.229380915141, 7442.702291908263, 7450.254974502506, 6738.0, 6765.864682706417, 6783.898241526283, 6791.185057793096, 6791.422729068085, 4855.927161092657, 5014.52362025607, 5083.593312534915, 5134.0, 5153.948460515347, 4988.42633097184, 5099.0, 5139.049275883974, 5173.81891633791, 5198.4801519847715], "value": 4320.188606835676, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.2508740691974, 302.47218603536834, 302.9530422784468, 305.1014761527303, 307.1246946203319, 5745.942540574598, 5783.884322313551, 5789.0, 5807.535397168227, 5830.183774271605, 5699.116636921273, 5709.828705138842, 5710.114932185518, 5726.255586773714, 5734.455226753462, 4152.792360381984, 4159.875203743893, 4360.847370342039, 4374.628156606692, 4376.627986621141, 4318.157959197958, 4341.088371442001, 4343.370211319372, 4347.087111706545, 4351.456067991501, 4041.5352234493116, 4326.891827704301, 4336.132773445308, 4336.633960302511, 4339.7396156230725, 4156.459660244179, 4313.352997050436, 4318.82724691012, 4353.0858519711055, 4359.280718681413, 3736.271427071722, 3741.307858046243, 3744.756590821588, 3759.6240375962184, 3765.265773174232, 5379.865503362447, 5455.954017243534, 5469.15228139635, 5480.534154596864, 5484.095124304485, 4976.87557811054, 4979.900401991976, 5000.649954503187, 5019.698818070891, 5025.6733312334945, 5887.322957859816, 5933.910991335133, 5940.524758019391, 5945.0, 5954.374790647006, 4060.979695101535, 4092.877213683594, 4155.459790227251, 4157.89815698837, 4163.791810409467, 6250.531210159256, 6259.749610015594, 6266.655333956631, 6274.341194174637, 6280.842978925563, 4262.552431994658, 4268.189044081614, 4273.995611031405, 4275.0, 4284.10033892886, 3974.2250261198787, 4316.913661726748, 4325.243082460557, 4328.458942632171, 4330.069035157457, 4903.215485522299, 4929.112759703216, 4934.333864928189, 4943.431505376856, 4949.678270912379, 6032.155498230251, 6040.577159598786, 6040.879182416327, 6043.8186854394435, 6047.304559975659, 1412.971740565183, 1436.2244388030347, 1450.8839292856546, 1454.527278634448, 1464.0629996802056, 848.6775025490274, 934.4907025671025, 939.8496240601607, 958.8513780364054, 963.1764841060932, 5767.394423585463, 5779.682117483495, 5796.536277097822, 5798.768049277982, 5799.82600521985, 6163.0, 6166.630002199882, 6175.752969881154, 6191.752329906843, 6205.906911396332, 5585.273914391103, 5823.359430462646, 5924.4667979882015, 5931.466168044896, 5941.851453713605, 3331.3170799985946, 3346.6486018968144, 3347.2134048498583, 3347.292880630847, 3354.4297469430257, 6265.96867015662, 6446.258680251831, 6460.773872914519, 6463.4506066983895, 6476.740930362827, 6328.905066424008, 6354.650494222769, 6378.17083779115, 6408.654182621608, 6446.613203207822, 6119.938800611937, 6435.74257029723, 6438.645874476855, 6442.710078046499, 6447.516436267205, 6261.5616906816085, 6299.905501417391, 6301.684915754102, 6307.873842523216, 6321.51444410554, 6166.969165154325, 6203.0, 6222.751089956532, 6223.284322302993, 6234.407731265523, 6304.936950630435, 6508.772192973223, 6521.011091616912, 6526.0, 6529.412352888263, 4104.466419365583, 4164.958350416457, 4184.937225941674, 4186.1418409225425, 4207.758711180148, 6190.659513726789, 6260.906086408617, 6300.117983482408, 6314.810555683337, 6323.146375239284, 6044.516438684983, 6076.210092687922, 6078.787242446493, 6093.390660933871, 6097.847553811191, 6035.849103772441, 6046.2139921809885, 6050.45545900871, 6054.3340232575265, 6057.303410107894, 5737.139429085671, 5739.149374307059, 5866.384029676822, 5906.616069955439, 5994.130851026664, 6072.696365181635, 6088.4824789893355, 6096.786612468542, 6107.206063211754, 6110.847228819315, 5678.716064196691, 5941.287045554561, 5942.851428714317, 5950.72059507208, 5955.612885162451], "value": 4514.4703537733585, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [816.852966466036, 836.8159005018902, 841.9747407577768, 851.9531425771584, 877.9912200877991, 14093.57719268421, 14456.638584035405, 14459.638509037266, 14484.855151448483, 14486.999999999987, 13631.659208519768, 13724.176549407042, 14226.217558034305, 14259.714805703905, 14263.572092837205, 680.2823021712092, 803.5178892664413, 811.0956283743642, 815.5106935838479, 817.15832692327, 792.1563534835382, 821.1788211788212, 825.1707034430419, 825.7852958230873, 826.182079741058, 858.841114393836, 859.4843094143527, 860.9956950215271, 861.3755027604999, 862.9352798540103, 706.5725236232108, 723.9167495738005, 846.8645016797313, 850.5109562001843, 852.6759831264142, 532.6324835863242, 606.5420607441398, 625.3715016408526, 629.5184184099168, 629.559308484063, 14507.637309067251, 14531.491397801026, 14536.127832329988, 14582.4896128635, 14633.048851824597, 14183.290835458289, 14503.0, 14570.854291457055, 14703.19132447715, 14724.0, 10294.227932905062, 10347.120494757955, 10373.118284945713, 10408.47957602117, 10462.843057354146, 3674.9448758268645, 3755.906102347436, 3781.149241420686, 3802.239552089593, 3839.7120215983914, 53731.731341343046, 54092.72953635207, 54515.72742136304, 54555.0, 54574.18138727922, 9670.178034866974, 9916.543450000434, 9948.552315145836, 10151.1371533419, 10372.066514013775, 20231.595368092556, 20240.392788216082, 20273.49316267105, 20281.79718202799, 20281.898590506953, 7789.961050194713, 7920.247576480225, 8072.192780721881, 8094.109647938722, 8127.471714338549, 4246.150769846043, 4421.602055814992, 4436.0240747035605, 4511.481179664315, 4556.589906908394, 3010.969890301069, 3073.2163298359224, 3073.8770449181784, 3078.6767389424235, 3082.05997170865, 571.5427657873685, 577.8093229234343, 577.9971100144472, 582.5776312173725, 590.6101972697999, 597.4354235247649, 677.617146312332, 681.4888833374969, 682.8975653651992, 702.2906864067329, 8349.33205343571, 8698.086700896441, 8881.200691937756, 8947.628878347243, 8966.551672416483, 620.2371083567148, 635.9554831161867, 671.4427025568766, 672.5426709837358, 679.0154276299386, 3977.9204415911518, 4021.416894550274, 4052.392141178788, 4088.3049881520215, 4220.07158425146, 54557.72721136369, 56438.71780641071, 56524.0, 64773.0, 65275.67362163159, 52499.47500525022, 53635.19547206795, 53734.46265537295, 54215.662746980146, 54923.176152357744, 47888.760556197696, 48153.5184648149, 48239.75880120577, 49435.75282123566, 50052.74973625181, 8677.088905664814, 8891.73324800257, 8896.199342059246, 9086.273098152264, 9274.165325120772, 32856.50715239225, 33828.3234335307, 34365.484517731755, 34554.481682774276, 34986.12534686653, 43515.0, 47827.76086119547, 48360.7581962102, 48496.0, 48855.0, 10747.140228781835, 11053.668389948314, 11074.723131921766, 11413.144014199135, 11447.427628618703, 12462.501499940263, 12582.622521324374, 12591.0, 12665.240085594894, 12949.223046617233, 9143.268538517035, 11243.0, 11495.655130346104, 11636.94181529087, 12082.939585302018, 11506.194566380607, 11546.538138474367, 11634.185607007767, 11731.706707332385, 11760.76478470443, 11567.305961642329, 11633.53465861356, 11707.121965852424, 11709.494306012566, 11938.761224775282, 9187.0, 9597.23222142241, 9695.22438204956, 9793.363431376938, 9807.313488056054, 10082.495875206358, 10115.140213081677, 10179.338343007681, 10222.6422075227, 10332.0], "value": 6511.043910022294, "unit": "score"}], "name": "dromaeo_css", "value": 6945.220932679811, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 107.0, 113.0, 114.0, 113.0, 102.0, 113.0, 112.0, 111.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 128.0, 157.0, 180.0, 129.0, 155.0, 155.0, 128.0, 182.0, 126.0], "value": 149.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 162.0, 161.0, 160.0, 161.0, 162.0, 160.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 98.0, 115.0, 78.0, 76.0, 75.0, 131.0, 110.0, 76.0], "value": 91.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 93.0, 155.0, 92.0, 92.0, 92.0, 145.0, 93.0, 92.0, 145.0], "value": 109.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 116.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 145.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 94.0, 96.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 55.0, 55.0, 59.0, 55.0, 57.0, 80.0, 54.0, 51.0], "value": 57.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 61.0, 60.0, 61.0, 60.0, 61.0, 61.0, 62.0, 61.0], "value": 61.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 76.0, 77.0, 77.0, 76.0, 87.0, 78.0, 78.0], "value": 77.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 130.0, 135.0, 134.0, 122.0, 123.0, 126.0, 123.0, 161.0, 126.0], "value": 131.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 162.0, 169.0, 164.0, 165.0, 164.0, 163.0, 162.0, 167.0, 166.0], "value": 164.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 67.0, 68.0, 69.0, 68.0, 67.0, 67.0, 68.0, 68.0], "value": 67.9, "unit": "score"}], "name": "kraken", "value": 1539.5000000000002, "alertThreshold": 2.0}]} 22:27:35 INFO - Return code: 0 22:27:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:27:36 ERROR - # TBPL SUCCESS # 22:27:36 INFO - Running post-action listener: _resource_record_post_action 22:27:36 INFO - Running post-run listener: _resource_record_post_run 22:27:37 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 535883776; Read time: 0; Write time: 455604 22:27:37 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 244514816; Read time: 0; Write time: 212264 22:27:37 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 291368960; Read time: 0; Write time: 243340 22:27:37 INFO - Running post-run listener: _upload_blobber_files 22:27:37 INFO - Blob upload gear active. 22:27:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:27:37 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 22:27:37 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:27:37 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:27:37 INFO - (blobuploader) - INFO - Open directory for files ... 22:27:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:27:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:27:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:27:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:27:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:27:38 INFO - (blobuploader) - INFO - Done attempting. 22:27:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:27:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:27:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:27:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:27:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:27:39 INFO - (blobuploader) - INFO - Done attempting. 22:27:39 INFO - (blobuploader) - INFO - Iteration through files over. 22:27:39 INFO - Return code: 0 22:27:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:27:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:27:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0fe504727d395726be0d493871fad0910b3f8351ca8104f587abadbf25266734c1f2ec0511f11198e090795ce3c0eb65abc7cc4be21366f243ce83aebc4e1ff4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2250812f6fa854b209e05fb8734cd3abd0eda77ac347918ebe6cbec979e99623d29a7db71edf2cccdb21009b806a15f608a258107e310d3d44ebb2fdf38ce808"} 22:27:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:27:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:27:39 INFO - Contents: 22:27:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0fe504727d395726be0d493871fad0910b3f8351ca8104f587abadbf25266734c1f2ec0511f11198e090795ce3c0eb65abc7cc4be21366f243ce83aebc4e1ff4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2250812f6fa854b209e05fb8734cd3abd0eda77ac347918ebe6cbec979e99623d29a7db71edf2cccdb21009b806a15f608a258107e310d3d44ebb2fdf38ce808"} 22:27:39 INFO - Running post-run listener: copy_logs_to_upload_dir 22:27:39 INFO - Copying logs to upload dir... 22:27:39 INFO - mkdir: /builds/slave/test/build/upload/logs 22:27:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.292724 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-04-20 22:27:38.889410) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 22:27:38.893529) ========= 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=652eb03db935cfc1c15ebda0000001ad-1461214287.617397-209692642 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0fe504727d395726be0d493871fad0910b3f8351ca8104f587abadbf25266734c1f2ec0511f11198e090795ce3c0eb65abc7cc4be21366f243ce83aebc4e1ff4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2250812f6fa854b209e05fb8734cd3abd0eda77ac347918ebe6cbec979e99623d29a7db71edf2cccdb21009b806a15f608a258107e310d3d44ebb2fdf38ce808"} build_url:https://queue.taskcluster.net/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011371 build_url: 'https://queue.taskcluster.net/v1/task/HDmByxdeTvqfi22_HKJTMQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0fe504727d395726be0d493871fad0910b3f8351ca8104f587abadbf25266734c1f2ec0511f11198e090795ce3c0eb65abc7cc4be21366f243ce83aebc4e1ff4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2250812f6fa854b209e05fb8734cd3abd0eda77ac347918ebe6cbec979e99623d29a7db71edf2cccdb21009b806a15f608a258107e310d3d44ebb2fdf38ce808"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 22:27:38.918723) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 22:27:38.919077) ========= 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=652eb03db935cfc1c15ebda0000001ad-1461214287.617397-209692642 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004381 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 22:27:39.002206) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 22:27:39.002519) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 22:27:39.002824) ========= ========= Total master_lag: 0.20 =========