builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-050 starttime: 1464621248.39 results: success (0) buildid: 20160530035543 builduid: 865ed214ad954ae683a81bd20aaeb948 revision: 04934785596476f6dd8baccc355202aeba59af35 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 08:14:08.388759) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-30 08:14:08.389615) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 08:14:08.390138) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-30 08:14:08.407921) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 08:14:08.408558) ========= 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=6dbc10da6d83fee962c624be000001a8-1464621247.789565-1446120904 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-30 08:14:08-- 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% 43.2M=0s 2016-05-30 08:14:08 (43.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.094706 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 08:14:08.518753) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 08:14:08.519094) ========= 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=6dbc10da6d83fee962c624be000001a8-1464621247.789565-1446120904 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021019 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 08:14:08.568925) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-30 08:14:08.569378) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 04934785596476f6dd8baccc355202aeba59af35 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 04934785596476f6dd8baccc355202aeba59af35 --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=6dbc10da6d83fee962c624be000001a8-1464621247.789565-1446120904 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-30 08:14:08,724 truncating revision to first 12 chars 2016-05-30 08:14:08,724 Setting DEBUG logging. 2016-05-30 08:14:08,724 attempt 1/10 2016-05-30 08:14:08,724 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/049347855964?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-30 08:14:09,513 unpacking tar archive at: mozilla-aurora-049347855964/testing/mozharness/ program finished with exit code 0 elapsedTime=1.098244 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-30 08:14:09.682230) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 08:14:09.682727) ========= script_repo_revision: 04934785596476f6dd8baccc355202aeba59af35 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-30 08:14:09.683239) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 08:14:09.683589) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-30 08:14:09.690107) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-05-30 08:14:09.690475) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=6dbc10da6d83fee962c624be000001a8-1464621247.789565-1446120904 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:14:09 INFO - MultiFileLogger online at 20160530 08:14:09 in /builds/slave/test 08:14:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:14:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:14:09 INFO - {'append_to_log': False, 08:14:09 INFO - 'base_work_dir': '/builds/slave/test', 08:14:09 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:14:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:14:09 INFO - 'branch': 'Mozilla-Aurora', 08:14:09 INFO - 'buildbot_json_path': 'buildprops.json', 08:14:09 INFO - 'config_files': ('talos/linux_config.py',), 08:14:09 INFO - 'default_actions': ('clobber', 08:14:09 INFO - 'read-buildbot-config', 08:14:09 INFO - 'download-and-extract', 08:14:09 INFO - 'populate-webroot', 08:14:09 INFO - 'create-virtualenv', 08:14:09 INFO - 'install', 08:14:09 INFO - 'run-tests'), 08:14:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:14:09 INFO - 'download_minidump_stackwalk': True, 08:14:09 INFO - 'download_symbols': 'ondemand', 08:14:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:14:09 INFO - 'tooltool.py': '/tools/tooltool.py', 08:14:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:14:09 INFO - '/tools/misc-python/virtualenv.py')}, 08:14:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:14:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:14:09 INFO - 'installer_path': 'installer.exe', 08:14:09 INFO - 'log_level': 'info', 08:14:09 INFO - 'log_name': 'talos', 08:14:09 INFO - 'log_to_console': True, 08:14:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:14:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:14:09 INFO - 'opt_config_files': (), 08:14:09 INFO - 'pip_index': False, 08:14:09 INFO - 'sps_profile': False, 08:14:09 INFO - 'sps_profile_interval': 0, 08:14:09 INFO - 'suite': 'dromaeojs', 08:14:09 INFO - 'system_bits': '32', 08:14:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:14:09 INFO - 'title': 'talos-linux64-ix-050', 08:14:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:14:09 INFO - 'use_talos_json': True, 08:14:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:14:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:14:09 INFO - 'work_dir': 'build'} 08:14:09 INFO - ##### 08:14:09 INFO - ##### Running clobber step. 08:14:09 INFO - ##### 08:14:09 INFO - Running pre-action listener: _resource_record_pre_action 08:14:09 INFO - Running main action method: clobber 08:14:09 INFO - rmtree: /builds/slave/test/build 08:14:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:14:10 INFO - Running post-action listener: _resource_record_post_action 08:14:10 INFO - ##### 08:14:10 INFO - ##### Running read-buildbot-config step. 08:14:10 INFO - ##### 08:14:10 INFO - Running pre-action listener: _resource_record_pre_action 08:14:10 INFO - Running main action method: read_buildbot_config 08:14:10 INFO - Using buildbot properties: 08:14:10 INFO - { 08:14:10 INFO - "project": "", 08:14:10 INFO - "product": "firefox", 08:14:10 INFO - "script_repo_revision": "production", 08:14:10 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 08:14:10 INFO - "repository": "", 08:14:10 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 08:14:10 INFO - "buildid": "20160530035543", 08:14:10 INFO - "pgo_build": "True", 08:14:10 INFO - "basedir": "/builds/slave/test", 08:14:10 INFO - "buildnumber": 269, 08:14:10 INFO - "slavename": "talos-linux64-ix-050", 08:14:10 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:14:10 INFO - "platform": "ubuntu64_hw", 08:14:10 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 08:14:10 INFO - "branch": "mozilla-aurora", 08:14:10 INFO - "repo_path": "releases/mozilla-aurora", 08:14:10 INFO - "revision": "04934785596476f6dd8baccc355202aeba59af35", 08:14:10 INFO - "stage_platform": "linux64-pgo", 08:14:10 INFO - "builduid": "865ed214ad954ae683a81bd20aaeb948", 08:14:10 INFO - "slavebuilddir": "test" 08:14:10 INFO - } 08:14:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2. 08:14:10 INFO - Running post-action listener: _resource_record_post_action 08:14:10 INFO - ##### 08:14:10 INFO - ##### Running download-and-extract step. 08:14:10 INFO - ##### 08:14:10 INFO - Running pre-action listener: _resource_record_pre_action 08:14:10 INFO - Running main action method: download_and_extract 08:14:10 INFO - mkdir: /builds/slave/test/build/tests 08:14:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:10 INFO - https://queue.taskcluster.net/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:14:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 08:14:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 08:14:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 08:14:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:14:11 INFO - Downloaded 1361 bytes. 08:14:11 INFO - Reading from file /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.test_packages.json 08:14:11 INFO - Using the following test package requirements: 08:14:11 INFO - {u'common': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 08:14:11 INFO - u'cppunittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 08:14:11 INFO - u'firefox-48.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 08:14:11 INFO - u'gtest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 08:14:11 INFO - u'firefox-48.0a2.en-US.linux-x86_64.gtest.tests.zip'], 08:14:11 INFO - u'jittest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 08:14:11 INFO - u'jsshell-linux-x86_64.zip'], 08:14:11 INFO - u'mochitest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 08:14:11 INFO - u'firefox-48.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 08:14:11 INFO - u'mozbase': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'], 08:14:11 INFO - u'reftest': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 08:14:11 INFO - u'firefox-48.0a2.en-US.linux-x86_64.reftest.tests.zip'], 08:14:11 INFO - u'talos': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 08:14:11 INFO - u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'], 08:14:11 INFO - u'web-platform': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 08:14:11 INFO - u'firefox-48.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 08:14:11 INFO - u'xpcshell': [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 08:14:11 INFO - u'firefox-48.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 08:14:11 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:14:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:11 INFO - https://queue.taskcluster.net/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:14:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 08:14:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 08:14:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 08:14:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:14:12 INFO - Downloaded 24135385 bytes. 08:14:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:14:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:14:13 INFO - Return code: 0 08:14:13 INFO - Downloading packages: [u'firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:14:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:13 INFO - https://queue.taskcluster.net/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:14:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 08:14:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 08:14:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip 08:14:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:14:15 INFO - Downloaded 24135385 bytes. 08:14:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:14:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:14:16 INFO - Return code: 0 08:14:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:16 INFO - https://queue.taskcluster.net/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:14:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 08:14:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 08:14:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip 08:14:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:14:17 INFO - Downloaded 10840145 bytes. 08:14:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:14:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:14:17 INFO - Return code: 0 08:14: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')]} 08:14:17 INFO - https://queue.taskcluster.net/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:14:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 08:14:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 08:14:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 08:14:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:14:19 INFO - Downloaded 62736116 bytes. 08:14:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 08:14:19 INFO - mkdir: /builds/slave/test/properties 08:14:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:14:19 INFO - Writing to file /builds/slave/test/properties/build_url 08:14:19 INFO - Contents: 08:14:19 INFO - build_url:https://queue.taskcluster.net/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 08:14:19 INFO - Running post-action listener: _resource_record_post_action 08:14:19 INFO - Running post-action listener: set_extra_try_arguments 08:14:19 INFO - ##### 08:14:19 INFO - ##### Running populate-webroot step. 08:14:19 INFO - ##### 08:14:19 INFO - Running pre-action listener: _resource_record_pre_action 08:14:19 INFO - Running main action method: populate_webroot 08:14:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:14:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:14:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:14:19 INFO - '--tppagecycles', 08:14:19 INFO - '7'], 08:14:19 INFO - 'tests': ['tsvgm']}}, 08:14:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:14:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:14:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:14:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:14:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:14:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:14:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:19 INFO - 'talos_options': ['--disable-e10s'], 08:14:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:14:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:14:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:19 INFO - 'talos_options': ['--disable-e10s'], 08:14:19 INFO - 'tests': ['damp', 'tps']}, 08:14:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:19 INFO - 'tests': ['damp', 'tps']}, 08:14:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:14:19 INFO - 'tests': ['dromaeo_dom']}, 08:14:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:14:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:14:19 INFO - 'tests': ['a11yr', 08:14:19 INFO - 'ts_paint', 08:14:19 INFO - 'tpaint', 08:14:19 INFO - 'sessionrestore', 08:14:19 INFO - 'sessionrestore_no_auto_restore', 08:14:19 INFO - 'tabpaint']}, 08:14:19 INFO - 'other-e10s': {'tests': ['a11yr', 08:14:19 INFO - 'ts_paint', 08:14:19 INFO - 'tpaint', 08:14:19 INFO - 'sessionrestore', 08:14:19 INFO - 'sessionrestore_no_auto_restore', 08:14:19 INFO - 'tabpaint']}, 08:14:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:14:19 INFO - 'ts_paint', 08:14:19 INFO - 'tpaint', 08:14:19 INFO - 'sessionrestore', 08:14:19 INFO - 'sessionrestore_no_auto_restore', 08:14:19 INFO - 'tabpaint']}, 08:14:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:14:19 INFO - 'ts_paint', 08:14:19 INFO - 'tpaint', 08:14:19 INFO - 'sessionrestore', 08:14:19 INFO - 'sessionrestore_no_auto_restore', 08:14:19 INFO - 'tabpaint']}, 08:14:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:14:19 INFO - 'tests': ['a11yr', 08:14:19 INFO - 'ts_paint', 08:14:19 INFO - 'tpaint', 08:14:19 INFO - 'sessionrestore', 08:14:19 INFO - 'sessionrestore_no_auto_restore', 08:14:19 INFO - 'tabpaint']}, 08:14:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:14:19 INFO - 'tests': ['a11yr', 08:14:19 INFO - 'ts_paint', 08:14:19 INFO - 'tpaint', 08:14:19 INFO - 'sessionrestore', 08:14:19 INFO - 'sessionrestore_no_auto_restore', 08:14:19 INFO - 'tabpaint']}, 08:14:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:14:19 INFO - 'tests': ['tsvgx', 08:14:19 INFO - 'tsvgr_opacity', 08:14:19 INFO - 'tart', 08:14:19 INFO - 'tscrollx', 08:14:19 INFO - 'cart']}, 08:14:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:14:19 INFO - 'tsvgr_opacity', 08:14:19 INFO - 'tart', 08:14:19 INFO - 'tscrollx', 08:14:19 INFO - 'cart']}, 08:14:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:19 INFO - 'talos_options': ['--disable-e10s'], 08:14:19 INFO - 'tests': ['tp5o']}, 08:14:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:19 INFO - 'tests': ['tp5o']}, 08:14:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:19 INFO - 'talos_options': ['--disable-e10s', 08:14:19 INFO - '--xperf_path', 08:14:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:14:19 INFO - 'tests': ['tp5n']}, 08:14:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:19 INFO - 'talos_options': ['--xperf_path', 08:14:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:14:19 INFO - 'tests': ['tp5n']}}, 08:14:19 INFO - 'talos.zip': {'path': '', 08:14:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:14:19 INFO - Running post-action listener: _resource_record_post_action 08:14:19 INFO - ##### 08:14:19 INFO - ##### Running create-virtualenv step. 08:14:19 INFO - ##### 08:14:19 INFO - Running pre-action listener: _resource_record_pre_action 08:14:19 INFO - Running main action method: create_virtualenv 08:14:19 INFO - Creating virtualenv /builds/slave/test/build/venv 08:14:19 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:14:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:14:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:14:19 INFO - Using real prefix '/usr' 08:14:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:14:20 INFO - Installing distribute.............................................................................................................................................................................................done. 08:14:22 INFO - Installing pip.................done. 08:14:22 INFO - Return code: 0 08:14:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:14:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:22 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 0x7f8c05381f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x289b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292a410>, '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 0x292b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x292b7a0>, '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': '6dbc10da6d83fee962c624be000001a8-1464621247.789565-1446120904', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:14:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:14:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:14:22 INFO - Using env: {'DISPLAY': ':0', 08:14:22 INFO - 'HOME': '/home/cltbld', 08:14:22 INFO - 'LANG': 'en_US.UTF-8', 08:14:22 INFO - 'LANGUAGE': 'en_US:en', 08:14:22 INFO - 'LOGNAME': 'cltbld', 08:14:22 INFO - 'MAIL': '/var/mail/cltbld', 08:14:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:22 INFO - 'MOZ_NO_REMOTE': '1', 08:14:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:22 INFO - 'NO_EM_RESTART': '1', 08:14:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:22 INFO - 'PWD': '/builds/slave/test', 08:14:22 INFO - 'SHELL': '/bin/bash', 08:14:22 INFO - 'SHLVL': '1', 08:14:22 INFO - 'TERM': 'linux', 08:14:22 INFO - 'TMOUT': '86400', 08:14:22 INFO - 'USER': 'cltbld', 08:14:22 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1464621247.789565-1446120904', 08:14:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:22 INFO - '_': '/tools/buildbot/bin/python'} 08:14:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:22 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:14:22 INFO - Cleaning up... 08:14:22 INFO - Return code: 0 08:14:22 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:14:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:22 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 0x7f8c05381f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x289b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292a410>, '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 0x292b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x292b7a0>, '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': '6dbc10da6d83fee962c624be000001a8-1464621247.789565-1446120904', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:14:22 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 08:14:22 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 08:14:22 INFO - Using env: {'DISPLAY': ':0', 08:14:22 INFO - 'HOME': '/home/cltbld', 08:14:22 INFO - 'LANG': 'en_US.UTF-8', 08:14:22 INFO - 'LANGUAGE': 'en_US:en', 08:14:22 INFO - 'LOGNAME': 'cltbld', 08:14:22 INFO - 'MAIL': '/var/mail/cltbld', 08:14:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:22 INFO - 'MOZ_NO_REMOTE': '1', 08:14:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:22 INFO - 'NO_EM_RESTART': '1', 08:14:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:22 INFO - 'PWD': '/builds/slave/test', 08:14:22 INFO - 'SHELL': '/bin/bash', 08:14:22 INFO - 'SHLVL': '1', 08:14:22 INFO - 'TERM': 'linux', 08:14:22 INFO - 'TMOUT': '86400', 08:14:22 INFO - 'USER': 'cltbld', 08:14:22 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1464621247.789565-1446120904', 08:14:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:22 INFO - '_': '/tools/buildbot/bin/python'} 08:14:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:22 INFO - Downloading/unpacking psutil>=0.7.1 08:14:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:14:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:14:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:14:24 INFO - Installing collected packages: psutil 08:14:24 INFO - Running setup.py install for psutil 08:14:24 INFO - building 'psutil._psutil_linux' extension 08:14:24 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:14:25 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:14:25 INFO - building 'psutil._psutil_posix' extension 08:14:25 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:14:25 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:14:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:14:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:14:25 INFO - Successfully installed psutil 08:14:25 INFO - Cleaning up... 08:14:25 INFO - Return code: 0 08:14:25 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:14:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8c05381f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x289b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292a410>, '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 0x292b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x292b7a0>, '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': '6dbc10da6d83fee962c624be000001a8-1464621247.789565-1446120904', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:14:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 08:14:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 08:14:25 INFO - Using env: {'DISPLAY': ':0', 08:14:25 INFO - 'HOME': '/home/cltbld', 08:14:25 INFO - 'LANG': 'en_US.UTF-8', 08:14:25 INFO - 'LANGUAGE': 'en_US:en', 08:14:25 INFO - 'LOGNAME': 'cltbld', 08:14:25 INFO - 'MAIL': '/var/mail/cltbld', 08:14:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:25 INFO - 'MOZ_NO_REMOTE': '1', 08:14:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:25 INFO - 'NO_EM_RESTART': '1', 08:14:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:25 INFO - 'PWD': '/builds/slave/test', 08:14:25 INFO - 'SHELL': '/bin/bash', 08:14:25 INFO - 'SHLVL': '1', 08:14:25 INFO - 'TERM': 'linux', 08:14:25 INFO - 'TMOUT': '86400', 08:14:25 INFO - 'USER': 'cltbld', 08:14:25 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1464621247.789565-1446120904', 08:14:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:25 INFO - '_': '/tools/buildbot/bin/python'} 08:14:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:25 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:27 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:14:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:14:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:14:27 INFO - Installing collected packages: mozsystemmonitor 08:14:27 INFO - Running setup.py install for mozsystemmonitor 08:14:27 INFO - Successfully installed mozsystemmonitor 08:14:27 INFO - Cleaning up... 08:14:27 INFO - Return code: 0 08:14:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:14:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:27 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 0x7f8c05381f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x289b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292a410>, '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 0x292b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x292b7a0>, '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': '6dbc10da6d83fee962c624be000001a8-1464621247.789565-1446120904', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:14:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:14:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:14:27 INFO - Using env: {'DISPLAY': ':0', 08:14:27 INFO - 'HOME': '/home/cltbld', 08:14:27 INFO - 'LANG': 'en_US.UTF-8', 08:14:27 INFO - 'LANGUAGE': 'en_US:en', 08:14:27 INFO - 'LOGNAME': 'cltbld', 08:14:27 INFO - 'MAIL': '/var/mail/cltbld', 08:14:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:27 INFO - 'MOZ_NO_REMOTE': '1', 08:14:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:27 INFO - 'NO_EM_RESTART': '1', 08:14:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:27 INFO - 'PWD': '/builds/slave/test', 08:14:27 INFO - 'SHELL': '/bin/bash', 08:14:27 INFO - 'SHLVL': '1', 08:14:27 INFO - 'TERM': 'linux', 08:14:27 INFO - 'TMOUT': '86400', 08:14:27 INFO - 'USER': 'cltbld', 08:14:27 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1464621247.789565-1446120904', 08:14:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:27 INFO - '_': '/tools/buildbot/bin/python'} 08:14:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:27 INFO - Downloading/unpacking blobuploader==1.2.4 08:14:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:29 INFO - Downloading blobuploader-1.2.4.tar.gz 08:14:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:14:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:14: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 08:14: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 08:14: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 08:14: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 08:14: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 08:14: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 08:14:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:14:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:14:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:30 INFO - Downloading docopt-0.6.1.tar.gz 08:14:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:14:30 INFO - Installing collected packages: blobuploader, requests, docopt 08:14:30 INFO - Running setup.py install for blobuploader 08:14:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:14:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:14:30 INFO - Running setup.py install for requests 08:14:30 INFO - Running setup.py install for docopt 08:14:31 INFO - Successfully installed blobuploader requests docopt 08:14:31 INFO - Cleaning up... 08:14:31 INFO - Return code: 0 08:14:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:14:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:31 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 0x7f8c05381f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x289b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292a410>, '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 0x292b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x292b7a0>, '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': '6dbc10da6d83fee962c624be000001a8-1464621247.789565-1446120904', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:14:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:14:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:14:31 INFO - Using env: {'DISPLAY': ':0', 08:14:31 INFO - 'HOME': '/home/cltbld', 08:14:31 INFO - 'LANG': 'en_US.UTF-8', 08:14:31 INFO - 'LANGUAGE': 'en_US:en', 08:14:31 INFO - 'LOGNAME': 'cltbld', 08:14:31 INFO - 'MAIL': '/var/mail/cltbld', 08:14:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:31 INFO - 'MOZ_NO_REMOTE': '1', 08:14:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:31 INFO - 'NO_EM_RESTART': '1', 08:14:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:31 INFO - 'PWD': '/builds/slave/test', 08:14:31 INFO - 'SHELL': '/bin/bash', 08:14:31 INFO - 'SHLVL': '1', 08:14:31 INFO - 'TERM': 'linux', 08:14:31 INFO - 'TMOUT': '86400', 08:14:31 INFO - 'USER': 'cltbld', 08:14:31 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1464621247.789565-1446120904', 08:14:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:31 INFO - '_': '/tools/buildbot/bin/python'} 08:14:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:14:31 INFO - Running setup.py (path:/tmp/pip-JMczMY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:14:31 INFO - Running setup.py (path:/tmp/pip-MP7I09-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:14:31 INFO - Running setup.py (path:/tmp/pip-jmlTES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:14:31 INFO - Running setup.py (path:/tmp/pip-UE8VJV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:14:31 INFO - Running setup.py (path:/tmp/pip-G6Tj_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:14:31 INFO - Running setup.py (path:/tmp/pip-TpQjQG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:14:31 INFO - Running setup.py (path:/tmp/pip-Qxau14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:14:31 INFO - Running setup.py (path:/tmp/pip-bME3H4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:14:31 INFO - Running setup.py (path:/tmp/pip-nZp4Pz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:14:31 INFO - Running setup.py (path:/tmp/pip-RFy4Qd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:14:32 INFO - Running setup.py (path:/tmp/pip-9Uk05q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:14:32 INFO - Running setup.py (path:/tmp/pip-TKuD38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:14:32 INFO - Running setup.py (path:/tmp/pip-cukICY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:14:32 INFO - Running setup.py (path:/tmp/pip-sT80gJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:32 INFO - Running setup.py (path:/tmp/pip-wffFlz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:14:32 INFO - Running setup.py (path:/tmp/pip-RkpMJN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:14:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:14:32 INFO - Running setup.py (path:/tmp/pip-buCsWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:14:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:14:32 INFO - Running setup.py install for manifestparser 08:14:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:14:32 INFO - Running setup.py install for mozcrash 08:14:32 INFO - Running setup.py install for mozdebug 08:14:32 INFO - Running setup.py install for mozdevice 08:14:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:14:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:14:32 INFO - Running setup.py install for mozfile 08:14:33 INFO - Running setup.py install for mozhttpd 08:14:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:14:33 INFO - Running setup.py install for mozinfo 08:14:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:14:33 INFO - Running setup.py install for mozInstall 08:14:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:14:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:14:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:14:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:14:33 INFO - Running setup.py install for mozleak 08:14:33 INFO - Running setup.py install for mozlog 08:14:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:14:33 INFO - Running setup.py install for moznetwork 08:14:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:14:33 INFO - Running setup.py install for mozprocess 08:14:33 INFO - Running setup.py install for mozprofile 08:14:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:14:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:14:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:14:33 INFO - Running setup.py install for mozrunner 08:14:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:14:34 INFO - Running setup.py install for mozscreenshot 08:14:34 INFO - Running setup.py install for moztest 08:14:34 INFO - Running setup.py install for mozversion 08:14:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:14:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:14:34 INFO - Cleaning up... 08:14:34 INFO - Return code: 0 08:14:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:34 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 0x7f8c05381f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x289b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292a410>, '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 0x292b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x292b7a0>, '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': '6dbc10da6d83fee962c624be000001a8-1464621247.789565-1446120904', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:14:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:14:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:14:34 INFO - Using env: {'DISPLAY': ':0', 08:14:34 INFO - 'HOME': '/home/cltbld', 08:14:34 INFO - 'LANG': 'en_US.UTF-8', 08:14:34 INFO - 'LANGUAGE': 'en_US:en', 08:14:34 INFO - 'LOGNAME': 'cltbld', 08:14:34 INFO - 'MAIL': '/var/mail/cltbld', 08:14:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:34 INFO - 'MOZ_NO_REMOTE': '1', 08:14:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:34 INFO - 'NO_EM_RESTART': '1', 08:14:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:34 INFO - 'PWD': '/builds/slave/test', 08:14:34 INFO - 'SHELL': '/bin/bash', 08:14:34 INFO - 'SHLVL': '1', 08:14:34 INFO - 'TERM': 'linux', 08:14:34 INFO - 'TMOUT': '86400', 08:14:34 INFO - 'USER': 'cltbld', 08:14:34 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1464621247.789565-1446120904', 08:14:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:34 INFO - '_': '/tools/buildbot/bin/python'} 08:14:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:14:34 INFO - Running setup.py (path:/tmp/pip-c4veaM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:14:34 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:14:34 INFO - Running setup.py (path:/tmp/pip-_IjPGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:14:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:14:34 INFO - Running setup.py (path:/tmp/pip-MHcRkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:14:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:14:34 INFO - Running setup.py (path:/tmp/pip-Nfe85U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:14:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:14:34 INFO - Running setup.py (path:/tmp/pip-of7Bft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:14:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:14:34 INFO - Running setup.py (path:/tmp/pip-LZS0vS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:14:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:14:34 INFO - Running setup.py (path:/tmp/pip-ObuooC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:14:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:14:35 INFO - Running setup.py (path:/tmp/pip-RAnonG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:14:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:14:35 INFO - Running setup.py (path:/tmp/pip-aGs5c7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:14:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:14:35 INFO - Running setup.py (path:/tmp/pip-5Jh6gg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:14:35 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)) 08:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:14:35 INFO - Running setup.py (path:/tmp/pip-WisgFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:14:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:14:35 INFO - Running setup.py (path:/tmp/pip-ow6MDK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:14:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:14:35 INFO - Running setup.py (path:/tmp/pip-WKPdNk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:14:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:14:35 INFO - Running setup.py (path:/tmp/pip-PGodf4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:14:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:35 INFO - Running setup.py (path:/tmp/pip-Liejh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:14:35 INFO - Running setup.py (path:/tmp/pip-2aF7Fd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:14:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:14:35 INFO - Running setup.py (path:/tmp/pip-_k0mse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:14:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:14:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:14:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:14:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:14:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:14:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:14:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:14:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:37 INFO - Downloading blessings-1.6.tar.gz 08:14:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:14:37 INFO - Installing collected packages: blessings 08:14:37 INFO - Running setup.py install for blessings 08:14:37 INFO - Successfully installed blessings 08:14:37 INFO - Cleaning up... 08:14:37 INFO - Return code: 0 08:14:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:14:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:14:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:14:38 INFO - Reading from file tmpfile_stdout 08:14:38 INFO - Current package versions: 08:14:38 INFO - argparse == 1.2.1 08:14:38 INFO - blessings == 1.6 08:14:38 INFO - blobuploader == 1.2.4 08:14:38 INFO - docopt == 0.6.1 08:14:38 INFO - manifestparser == 1.1 08:14:38 INFO - mozInstall == 1.12 08:14:38 INFO - mozcrash == 0.17 08:14:38 INFO - mozdebug == 0.1 08:14:38 INFO - mozdevice == 0.48 08:14:38 INFO - mozfile == 1.2 08:14:38 INFO - mozhttpd == 0.7 08:14:38 INFO - mozinfo == 0.9 08:14:38 INFO - mozleak == 0.1 08:14:38 INFO - mozlog == 3.1 08:14:38 INFO - moznetwork == 0.27 08:14:38 INFO - mozprocess == 0.22 08:14:38 INFO - mozprofile == 0.28 08:14:38 INFO - mozrunner == 6.11 08:14:38 INFO - mozscreenshot == 0.1 08:14:38 INFO - mozsystemmonitor == 0.0 08:14:38 INFO - moztest == 0.7 08:14:38 INFO - mozversion == 1.4 08:14:38 INFO - psutil == 3.1.1 08:14:38 INFO - requests == 1.2.3 08:14:38 INFO - wsgiref == 0.1.2 08:14:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:14:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:38 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 0x7f8c05381f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x289b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292a410>, '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 0x292b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x292b7a0>, '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': '6dbc10da6d83fee962c624be000001a8-1464621247.789565-1446120904', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:14:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:14:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:14:38 INFO - Using env: {'DISPLAY': ':0', 08:14:38 INFO - 'HOME': '/home/cltbld', 08:14:38 INFO - 'LANG': 'en_US.UTF-8', 08:14:38 INFO - 'LANGUAGE': 'en_US:en', 08:14:38 INFO - 'LOGNAME': 'cltbld', 08:14:38 INFO - 'MAIL': '/var/mail/cltbld', 08:14:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:38 INFO - 'MOZ_NO_REMOTE': '1', 08:14:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:38 INFO - 'NO_EM_RESTART': '1', 08:14:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:38 INFO - 'PWD': '/builds/slave/test', 08:14:38 INFO - 'SHELL': '/bin/bash', 08:14:38 INFO - 'SHLVL': '1', 08:14:38 INFO - 'TERM': 'linux', 08:14:38 INFO - 'TMOUT': '86400', 08:14:38 INFO - 'USER': 'cltbld', 08:14:38 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1464621247.789565-1446120904', 08:14:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:38 INFO - '_': '/tools/buildbot/bin/python'} 08:14:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:14:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:14:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:14:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:14:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:14:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:14:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:14:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:14:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:14:38 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:14:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:14:38 INFO - Cleaning up... 08:14:38 INFO - Return code: 0 08:14:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:14:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:38 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 0x7f8c05381f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x289b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292a410>, '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 0x292b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x292b7a0>, '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': '6dbc10da6d83fee962c624be000001a8-1464621247.789565-1446120904', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:14:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:14:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:14:38 INFO - Using env: {'DISPLAY': ':0', 08:14:38 INFO - 'HOME': '/home/cltbld', 08:14:38 INFO - 'LANG': 'en_US.UTF-8', 08:14:38 INFO - 'LANGUAGE': 'en_US:en', 08:14:38 INFO - 'LOGNAME': 'cltbld', 08:14:38 INFO - 'MAIL': '/var/mail/cltbld', 08:14:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:38 INFO - 'MOZ_NO_REMOTE': '1', 08:14:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:38 INFO - 'NO_EM_RESTART': '1', 08:14:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:38 INFO - 'PWD': '/builds/slave/test', 08:14:38 INFO - 'SHELL': '/bin/bash', 08:14:38 INFO - 'SHLVL': '1', 08:14:38 INFO - 'TERM': 'linux', 08:14:38 INFO - 'TMOUT': '86400', 08:14:38 INFO - 'USER': 'cltbld', 08:14:38 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1464621247.789565-1446120904', 08:14:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:38 INFO - '_': '/tools/buildbot/bin/python'} 08:14:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:38 INFO - Downloading/unpacking jsonschema 08:14:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:14:40 INFO - Downloading/unpacking functools32 (from jsonschema) 08:14:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:40 INFO - Downloading functools32-3.2.3-2.tar.gz 08:14:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:14:40 INFO - warning: no files found matching '*.txt' 08:14:40 INFO - no previously-included directories found matching 'build' 08:14:40 INFO - no previously-included directories found matching 'dist' 08:14:40 INFO - no previously-included directories found matching '.git*' 08:14:40 INFO - Installing collected packages: jsonschema, functools32 08:14:40 INFO - Running setup.py install for functools32 08:14:40 INFO - warning: no files found matching '*.txt' 08:14:40 INFO - no previously-included directories found matching 'build' 08:14:40 INFO - no previously-included directories found matching 'dist' 08:14:40 INFO - no previously-included directories found matching '.git*' 08:14:40 INFO - Successfully installed jsonschema functools32 08:14:40 INFO - Cleaning up... 08:14:40 INFO - Return code: 0 08:14:40 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:14:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c05381f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x289b5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x292a410>, '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 0x292b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x292b7a0>, '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': '6dbc10da6d83fee962c624be000001a8-1464621247.789565-1446120904', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:14:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:14:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:14:40 INFO - Using env: {'DISPLAY': ':0', 08:14:40 INFO - 'HOME': '/home/cltbld', 08:14:40 INFO - 'LANG': 'en_US.UTF-8', 08:14:40 INFO - 'LANGUAGE': 'en_US:en', 08:14:40 INFO - 'LOGNAME': 'cltbld', 08:14:40 INFO - 'MAIL': '/var/mail/cltbld', 08:14:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:40 INFO - 'MOZ_NO_REMOTE': '1', 08:14:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:40 INFO - 'NO_EM_RESTART': '1', 08:14:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:40 INFO - 'PWD': '/builds/slave/test', 08:14:40 INFO - 'SHELL': '/bin/bash', 08:14:40 INFO - 'SHLVL': '1', 08:14:40 INFO - 'TERM': 'linux', 08:14:40 INFO - 'TMOUT': '86400', 08:14:40 INFO - 'USER': 'cltbld', 08:14:40 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1464621247.789565-1446120904', 08:14:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:40 INFO - '_': '/tools/buildbot/bin/python'} 08:14:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:41 INFO - Downloading/unpacking flake8 08:14: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 08:14: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 08:14: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 08:14: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 08:14: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 08:14: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 08:14:43 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:14:43 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:14:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:43 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:14:43 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:14:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:43 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:14:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:14:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:14:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:14:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:14:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:14:43 INFO - no previously-included directories found matching 'docs/_build' 08:14:43 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:14:43 INFO - Running setup.py install for pep8 08:14:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:14:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:14:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:14:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:14:43 INFO - no previously-included directories found matching 'docs/_build' 08:14:43 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:14:43 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:14:43 INFO - Cleaning up... 08:14:44 INFO - Return code: 0 08:14:44 INFO - Running post-action listener: _resource_record_post_action 08:14:44 INFO - Running post-action listener: _start_resource_monitoring 08:14:44 INFO - Starting resource monitoring. 08:14:44 INFO - ##### 08:14:44 INFO - ##### Running install step. 08:14:44 INFO - ##### 08:14:44 INFO - Running pre-action listener: _resource_record_pre_action 08:14:44 INFO - Running main action method: install 08:14:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:14:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:14:44 INFO - Reading from file tmpfile_stdout 08:14:44 INFO - Detecting whether we're running mozinstall >=1.0... 08:14:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:14:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:14:44 INFO - Reading from file tmpfile_stdout 08:14:44 INFO - Output received: 08:14:44 INFO - Usage: mozinstall [options] installer 08:14:44 INFO - Options: 08:14:44 INFO - -h, --help show this help message and exit 08:14:44 INFO - -d DEST, --destination=DEST 08:14:44 INFO - Directory to install application into. [default: 08:14:44 INFO - "/builds/slave/test"] 08:14:44 INFO - --app=APP Application being installed. [default: firefox] 08:14:44 INFO - mkdir: /builds/slave/test/build/application 08:14:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:14:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:14:59 INFO - Reading from file tmpfile_stdout 08:14:59 INFO - Output received: 08:14:59 INFO - /builds/slave/test/build/application/firefox/firefox 08:14:59 INFO - Running post-action listener: _resource_record_post_action 08:14:59 INFO - ##### 08:14:59 INFO - ##### Running run-tests step. 08:14:59 INFO - ##### 08:14:59 INFO - Running pre-action listener: _resource_record_pre_action 08:14:59 INFO - Running main action method: run_tests 08:14:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:14:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:14:59 INFO - Python 2.7.3 08:14:59 INFO - Return code: 0 08:14:59 INFO - grabbing minidump binary from tooltool 08:14:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:59 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 0x292a410>, '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 0x292b310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x292b7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:14:59 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:14:59 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:15:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:15:00 INFO - Return code: 0 08:15:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:15:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:15:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:15:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:15:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:15:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:15:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:15:00 INFO - Return code: 0 08:15:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 08:15:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --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 08:15:00 INFO - Using env: {'DISPLAY': ':0', 08:15:00 INFO - 'HOME': '/home/cltbld', 08:15:00 INFO - 'LANG': 'en_US.UTF-8', 08:15:00 INFO - 'LANGUAGE': 'en_US:en', 08:15:00 INFO - 'LOGNAME': 'cltbld', 08:15:00 INFO - 'MAIL': '/var/mail/cltbld', 08:15:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:15:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:15:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:00 INFO - 'MOZ_NO_REMOTE': '1', 08:15:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:15:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:00 INFO - 'NO_EM_RESTART': '1', 08:15:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:00 INFO - 'PWD': '/builds/slave/test', 08:15:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:15:00 INFO - 'SHELL': '/bin/bash', 08:15:00 INFO - 'SHLVL': '1', 08:15:00 INFO - 'TERM': 'linux', 08:15:00 INFO - 'TMOUT': '86400', 08:15:00 INFO - 'USER': 'cltbld', 08:15:00 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1464621247.789565-1446120904', 08:15:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:00 INFO - '_': '/tools/buildbot/bin/python'} 08:15:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 08:15:01 INFO - mozversion application_buildid: 20160530035543 08:15:01 INFO - mozversion application_changeset: 04934785596476f6dd8baccc355202aeba59af35 08:15:01 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:15:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:15:01 INFO - mozversion application_name: Firefox 08:15:01 INFO - mozversion application_remotingname: firefox-dev 08:15:01 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:15:01 INFO - mozversion application_vendor: Mozilla 08:15:01 INFO - mozversion application_version: 48.0a2 08:15:01 INFO - mozversion platform_buildid: 20160530035543 08:15:01 INFO - mozversion platform_changeset: 04934785596476f6dd8baccc355202aeba59af35 08:15:01 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:15:01 INFO - mozversion platform_version: 48.0a2 08:15:01 INFO - using testdate: 1464621301 08:15:01 INFO - actual date: 1464621301 08:15:01 INFO - starting webserver on 'localhost:52532' 08:15:01 INFO - SUITE-START | Running 2 tests 08:15:01 INFO - TEST-START | dromaeo_css 08:15:01 INFO - operating with platform_type : linux_ 08:15:01 INFO - Initialising browser for dromaeo_css test... 08:15:01 INFO - TEST-INFO | started process 2497 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplhjsND/profile http://localhost:52532/getInfo.html) 08:15:04 INFO - PROCESS | 2497 | __metrics Screen width/height:1600/1200 08:15:04 INFO - PROCESS | 2497 | colorDepth:24 08:15:04 INFO - PROCESS | 2497 | Browser inner width/height: 1024/697 08:15:04 INFO - PROCESS | 2497 | __metrics 08:15:05 ERROR - PROCESS | 2497 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:15:06 INFO - TEST-INFO | 2497: exit 0 08:15:06 INFO - Browser initialized. 08:15:06 INFO - Running cycle 1/1 for dromaeo_css test... 08:15:06 INFO - TEST-INFO | started process 2588 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplhjsND/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:15:18 INFO - PROCESS | 2588 | RSS: Main: 141512704 08:15:18 INFO - PROCESS | 2588 | 08:16:09 INFO - PROCESS | 2588 | 1464621369524 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:18:16 INFO - PROCESS | 2588 | Cycle 1(1): loaded http://localhost:52532/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52532/tests/dromaeo/cssquery-ext.html) 08:18:17 INFO - PROCESS | 2588 | RSS: Main: 249872384 08:18:17 INFO - PROCESS | 2588 | 08:21:20 INFO - PROCESS | 2588 | Cycle 1(1): loaded http://localhost:52532/tests/dromaeo/cssquery-ext.html (next: http://localhost:52532/tests/dromaeo/cssquery-jquery.html) 08:21:20 INFO - PROCESS | 2588 | RSS: Main: 227471360 08:21:20 INFO - PROCESS | 2588 | 08:24:22 INFO - PROCESS | 2588 | Cycle 1(1): loaded http://localhost:52532/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52532/tests/dromaeo/cssquery-mootools.html) 08:24:23 INFO - PROCESS | 2588 | RSS: Main: 229371904 08:24:23 INFO - PROCESS | 2588 | 08:27:24 INFO - PROCESS | 2588 | Cycle 1(1): loaded http://localhost:52532/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52532/tests/dromaeo/cssquery-prototype.html) 08:27:25 INFO - PROCESS | 2588 | RSS: Main: 219013120 08:27:25 INFO - PROCESS | 2588 | 08:30:28 INFO - PROCESS | 2588 | Cycle 1(1): loaded http://localhost:52532/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52532/tests/dromaeo/cssquery-yui.html) 08:30:28 INFO - PROCESS | 2588 | RSS: Main: 213712896 08:30:28 INFO - PROCESS | 2588 | 08:33:30 INFO - PROCESS | 2588 | Cycle 1(1): loaded http://localhost:52532/tests/dromaeo/cssquery-yui.html (next: http://localhost:52532/tests/dromaeo/cssquery-dojo.html) 08:33:31 INFO - PROCESS | 2588 | RSS: Main: 253956096 08:33:31 INFO - PROCESS | 2588 | 08:33:31 INFO - PROCESS | 2588 | __start_tp_report 08:33:31 INFO - PROCESS | 2588 | _x_x_mozilla_page_load 08:33:31 INFO - PROCESS | 2588 | _x_x_mozilla_page_load_details 08:33:31 INFO - PROCESS | 2588 | |i|pagename|runs| 08:33:31 INFO - PROCESS | 2588 | |0;dojo.html;3304.702576768091;3358.88243911463;3364.6298907120226;3370.1237678203665;3402.064432281122;5438.7824487020525;5445.564354851612;5457.863553411166;5458.9454105458935;5483.972580137103;5481.890362192754;5499.257600223968;5518.089515229993;5535;5545.722713864301;4861.805527778884;4993.725345106018;5106.795728170869;5158.509941555546;5195.168772996321;4921.064997650435;5010.924836127461;5022.271770593262;5023.14606516893;5023.673461225027;5005.54950054495;5046.697198168122;5059.468755780646;5070.442251352349;5093.26147708582;5112.130937740593;5126.5642420394315;5128.743562821881;5137.255098010767;5143.254228136918;4852.830150944736;4907.8773030674165;4967.652264341461;5024.371953505812;5051.747412629354;5348.625596208267;5388.164834450667;5391.460853914617;5391.81128660495;5407.5133238008375;5843.2695913010875;5859.824205273849;5861.062230043215;5863.560232982543;5869.706514674292;5900.734466948998;5923.229980102602;5955.791547295824;5978.940210597882;6011.699415029275;5509.669419834822;5526.253955716007;5553.6390134641115;5555.944440555583;5583.3858275589655;5895.616784908967;6067.271927368655;6075.513958883367;6077.604955677867;6084.939150608526;5735.856603584861;5794.333651630117;5795.275590551181;5810.6513609183585;5817.76728930838;5841.620294680917;5842.795502157489;5843.152742852348;5847.415258474119;5848.298204215436;5717.628354156966;5784.334801497882;5825.155352473867;5826.854328641733;5834.970825145932;5867.501262392659;5875.294964604275;5875.9118613220835;5913.201717768046;5916.053431450947;4478.149151661174;4482.618977386894;4483.55164483549;4489.663275254304;4509.1658043262105;3948.881533553998;3951.6443520082757;4034.91930161401;4036.1120553478186;4078.3270760324212;5581.7209139543675;5596.076647353141;5604.663720176803;5610.691411972299;5625.971870140705;5857.0335894577765;5857.882842343214;5859.736311865976;5859.882802343929;5868.061110222344;5451.591130665216;5581.413951535112;5597.132444471114;5635.887282254332;5645.125005624135;4919.385076865392;4949.950500494949;4950.133726597831;4953.678010929278;4980.5019498049905;6043.48630366415;6094.786682466181;6099.054646529795;6099.115628233882;6103.084537319349;5751.769929202785;5839.5036421904615;5885.764569417175;5898.469137777621;5907.852303692442;6133.6319820810895;6153.507719382349;6153.84615384619;6159.6612186330185;6163.660998645118;5671.744771485211;5861.9706901466925;5867.266591676041;5868.2077919482035;5871.588988770916;5863.384344643751;5918.852028699317;5921.911171332347;5951.732172052355;5970.462658360769;5772.422757724194;5779.537636988946;5782.3639399666845;5782.739776709974;5786.42135786418;5471.726264484973;5753.482186603226;5753.626014309057;5754.683492407958;5768.451997060272;5647.265855438766;5669.319681638065;5672.376038635664;5674.06377947634;5719.714014299185;5776.56675749312;5781.566382521243;5784.566157538117;5788.739506722123;5788.913166302593;5523.4200408956485;5604.663720176803;5654.06707893193;5695.0603150481365;5710.2576665033275 08:33:31 INFO - PROCESS | 2588 | |1;ext.html;598.9940100598996;648.9033533328671;656.3862788292944;664;671.9932800671992;31562.368752624934;32230.516542251884;32317.67682323176;32324.19189520263;32328.67671323286;39136;39926;39932;39972.80013599935;39973;8720.95639521803;8874.068222836573;8885.600147993357;8886.46681199127;8891.466512009269;8007.1992800720045;8655.264302534291;8771.736847894541;8796.912030879705;10580.4180770058;10485.475726213697;10570.947145264263;10582.100521455686;10585.682429527127;10589.947050264738;10384;10448.52981615829;10450.47747612624;10468.68593942183;10473.633422830164;8002.239787220205;10221.744456388575;10309.74225644365;10376.273660843744;10378.532966016548;40330.395044074365;40628;40705.18589628191;40881;40883.386749198784;3848.8589599700713;3861.7296789224765;3903.4535165076913;3937.6652984496354;3950.308695978221;33045.339093218245;33472.3305533888;33834.32331353384;34173;34175.6582434175;4586.610138138262;4628.3288923105965;4690.95309046912;4702.6002789762915;4719.10337035962;316056;316120;317548;319305.40347298345;319775;39368.80315598404;65796;66769.66615166893;66854.66572667105;66870;38814.22371552553;39102.608973910465;39114.413283800764;39129.217415651525;39192;16941;16994.49016529506;17062.573435664206;17143.485695429157;17156.31374745021;14467.204303763394;14508.637284067772;14554.27228638585;14559.19924404168;14559.85440145585;8785.165409286108;8953.776155596031;9367.484788336707;9445.669401570913;9511.714648560554;3561.4835848802295;3655.6527129922615;3696.9445458318146;3712.5916149223563;3714.57282412526;1078.4176544665793;1104.1111904916459;1133.6995696140364;1146.48408216303;1266.1643315411784;31165.532517012263;31499.685003150134;31577.842110789297;31975.680243197272;32479.350412991607;1207.372166473429;1237.9938100309441;1243.8569564500017;1257.1451413039222;1295.4105881823748;17531.824681753274;17691.646167076586;17830.821691783174;18041.909790450965;18147;496103;499667;501226;501446.9855301473;502158;61333.08000379998;62090.37909620936;62095.37904620896;62131;62192.37807621956;1360.3878254785188;1383.2253937794867;1544.8068991376078;1599.7440409534418;1604.4705247268373;30593.388132237676;33040.008799736046;33121.83439082789;33257.334853303284;33312;48197.51802481931;57912.710436447545;59608;59900;59901;425358;426156;428381;428905;428906;39236.41145382765;45730;46010.53989460196;46290.76854615705;46341.53658463372;44202.55797442113;44437;44858;45031;45207.773961129984;36259.27481450409;39643.603563965145;40383.192336152526;41263.587364127176;42109.57890421057;39612.40581391339;39945.60054399419;40296.798516007235;40556.79721601373;40814.387784183855;41656.375154373316;41686;41856.79071604623;43492.34761478517;44658.10683786241;32071.839640801645;34485.482717759754;36122.458163128096;36330.18349082588;36540;28219.71780282171;28655.283617909718;28832.567511486926;28856.278593035342;29017 08:33:31 INFO - PROCESS | 2588 | |2;jquery.html;427.57669906792285;428.66349915316465;433.89369604446915;435.1970614216769;435.7581542244054;18587;19110.617787644238;19112.713309300372;19285.807141928577;19946.301879434224;12489.375531223448;12810.807837882416;13204.626263433345;19866.304679336226;19953.501162470944;5311.760970756306;5416.404195538487;5425.565954723613;5466;5477.616566840323;5720.084786434171;5784.421557844203;5826.21346118275;5855.23881895353;5865.8240252792275;5747;5789.131630255453;5790.189373487715;5799.2750906136735;5800.883982320351;5672.858178545528;5776.220210271602;5810.070388737781;5815.447532484407;5818.679972601505;5182.507661772125;5222.63441559091;5225.242339860737;5230.424653288135;5238.449962753933;13755.10591811539;13978.93010534951;13984.021118521707;14121.646958826008;14123.223222722747;2335.2060299498253;2515.7735803777564;2542.555052865741;2771;2858.857057147134;10656.680299591024;10943.398113103776;11727.17909746318;13870.375833087535;15242.237888105661;2020.9393718188478;2031.7968203179712;2060.6393881070903;2127.4787677019076;2201.020545857094;75604;76436.61781691112;77121.61439192825;77571.22428775753;77668.22331776666;11202.271852329572;11250.268732532522;11257.380844053656;11373.943130284295;11742.647720568397;15623.53129406097;15646.9217653911;15740.134292614017;16001.439949601941;16081.35674573004;8782.560871956377;8848;8932.910670893338;8945;8972.41679290844;8892.421992570591;8960.103989601119;9042;9076.773080672903;9112.772180695536;4812.5668689818085;4819.3012013258585;4856.902861942742;4872.3909511311085;4907.1657818171;1947.2308438166845;1960.9117589708496;2005.9699104513445;2023.6559784836318;2035.8676686015658;917.8439665256923;994.7115336552318;1026.2508368890751;1027.8561001459802;1040.7502199472071;18457.353992610464;18885.92254851965;19591.706124408145;19900.60198796016;19930.90034549847;1024.472396715692;1027.5735569738474;1093.0431836750854;1114.2868564118971;1147.437755499799;10844.945775271231;11430.771384572428;11454.94272528632;11530.94234528822;11565.826512602318;476582;478231;481562;488902;490887;89492.5525372382;90110;92965.53517232371;93977.530112349;94976;1056.7939251845817;1064.723171975292;1076.4241130995038;1081.1837063017529;1093.2019625673145;17187.742183867;17294.74057889158;17358.73961890598;17360.131993400533;17409.390671326444;38938.80530597329;39430.408543872436;40068.1986360277;40145.79927100346;40504.392434112924;57110.42889571051;57117.42882571121;57343.139852901404;57490.137647934476;57572.1364179546;8766.561671916252;8912.420692654956;8972.37193396456;8992.59533320989;9058.456492610465;13026;13402.731945360843;13610.59168224955;13647.181169129884;13845.376958037114;8564.828703426021;11825.645230643095;12131.636050918487;12145.878541214475;12630.747385052431;11538.48076836561;11557.42212889369;11720.531178752753;11769.764604708029;12011.939940300243;12036.338001410006;12324.445399956845;12359.752804943671;12468;12657.430415631134;8805.823883522165;8820.603072861864;8858.291336693179;8871.157240062184;9225.907740922774;11918;11968.222065565711;12062.396880155782;12298.938505307417;12459.127861050001 08:33:31 INFO - PROCESS | 2588 | |3;mootools.html;1315.35547581685;1497.5133081748434;1566.7336552786028;1751.8773685841995;1875.1468082022682;7278.708851645934;8027.799305017377;8135.7152499662525;8148.225918537744;8159.91840081599;8031.558264295461;8182.181781821815;8182.91817081829;8191.344692424606;8209.6305666245;2063.6698128299477;2078.532330225702;2384.606539920911;2432.635104734291;2454.791342735861;2396.59257926153;2402.0992127952018;2405.0980882169188;2406.74729153439;2407.109369533275;2376.370261880603;2386.0217310902535;2412.1316326122583;2427.7329493755674;2429.927102186937;2049.3134799841996;2087.279888438486;2369.7393286738443;2397.8681172535503;2414.7343792182846;2368.9170879019152;2391.2587097999676;2395.0180426025245;2396.017632770573;2403.903843846244;8065.798355041171;8140.674373025131;8141.145179756099;8146.75559733209;8147.918520814835;5278.47215278473;5292.52367286946;5349.545288650469;5460.481254280837;5481.150421684605;3529.1177205698577;3534.469829525566;3563.055790215595;3571.982140089283;3635.3638113330326;1141.6460897121835;1172.5485688010092;1185.211834130311;1189.167582692119;1209.7338585511172;12194.81707774384;12202.328871912041;12204.633860984184;12206.877931220663;12217.694557636041;4732.73969931657;4761.166795810719;4837.95162048375;4840.160738919189;4841.806327746921;10379.377237365783;10399.740006499747;10405.791884162274;10406.895931040593;10429.530671119817;5418.593605479605;5419.647722897999;5450.563954883679;5451.890962180813;5452.509274165344;4233.597808208216;4765.809367625326;4837.927431088537;4839.056384005155;4849.2968519564465;4130.318497447887;4144.8756537303925;4169.3120635094865;4210.5578914214175;4214.05183833635;1295.8185853980451;1298.9740205195844;1351.8648135186402;1356.891448684103;1380.2684577173914;1067.0823092140752;1078.7087486378634;1085.5115198160702;1107.9113670906308;1114.7046032801313;5908;5971.850703732354;5986.102084687332;6052.485538729169;6113.877722445526;468.41916024129836;472.9219678753036;473.3515084334484;476.1476956248277;477.2840738891662;4175.603317684815;4205.095904380573;4212.220739163265;4214.557471465513;4278.764667943293;10338.224633152544;10670.573177072985;10786.352818830896;10861.511231994578;10873.401962892116;10195.847062293924;10618.097461715686;10633.096186824052;10633.89366106329;10644.467776611293;8020.318272946748;8022.75931722061;8055.718049868226;8152.673893044212;8188.50868947865;5722.713864306851;5783.190353350618;5827.3007239131575;5867.735951882261;5903.498202652822;9026.323025773225;9211.953940230256;9232.076792320715;9339.719808405758;9355.4386736796;9252.676156334495;9386.95306523463;9527.952360238154;9540.189083927666;9559.952200238955;6850.8972365413565;7379.926200737924;7434.959105725311;7621.428392870446;7757.650905709143;7858.0570331560575;7868.488548244346;7896.881546776918;7943.4836735612;7952.761417157494;7022.789316320519;7335.413166946525;7363.705451781869;7390.224026477357;7467.551946883204;7179;7179.210556546206;7223.783286501413;7248.746293879689;7379.8155046124275;6587.703553340207;6628.767993120217;6659.067730517634;6662.56693314933;6672.633005184762;4939.678920870132;4958.776855041604;4987.226979818134;5107.41264754558;5113.821016264413;5081.136206844919;5086.338775959101;5090.109230884506;5096.617753668564;5196.038732834438 08:33:31 INFO - PROCESS | 2588 | |4;prototype.html;343.6700767263427;347.3521881690646;367.9595244523102;369.0975564744202;371.0778714893491;6243.625382477049;6256.906146407802;6281.748730050798;6281.842953926142;6337.207849018872;6270.9686451567795;6271.059341098826;6271.623702577848;6272.059191121334;6279.8116056518265;4564.657650676196;4692.554207350297;4779.28310753388;4799.3280940668155;4807.182778927573;4786.593139583139;4813.542713442217;4835.178019736635;4843.515648435164;4848.442429120643;4613.746243956581;4829.372181616385;4836.177849765549;4841.031793641268;4844.539768721966;4662.696924699883;4745.786439610209;4751.192297309466;4760.976195119037;4805.135075686375;4242.087951090531;4242.766647834368;4249.893752656178;4255.127698821734;4256.59562341577;6018.458338749533;6024.397560243984;6035.577509574332;6038.667873266969;6041.5468839837185;5589.888202235973;5590;5593.664380137205;5597.524210442118;5601.60788744784;6457.61254324742;6591.242007169141;6597.47220222381;6598;6601.504887133437;4683.718976861399;4691.038337140912;4692.554207350297;4700.929486057712;4702.835400760991;6870.896936545956;6945.027696122547;6948.756793512202;6952.409045231161;6953.374196322305;4799.256115302133;4803.471618122004;4804.159272127434;4805.207140821795;4806.94247265601;4845.903081938412;4862.222044472867;4863.367762190964;4865.343178670834;4869.878253043631;5554.333479982347;5555.944440555623;5559.16612508127;5572.888542229132;5573.275474188411;6452.1289625900845;6628.204615446178;6631.635260060743;6641.767538136142;6644.700988455531;1692.1792930428733;1721.28566644841;1723.2676112652073;1723.4571110100528;1727.1278004607593;1046.4453839465095;1137.612113221868;1150.913681473893;1161.2509931094396;1176.5764324843049;6364.586301890362;6505.41451269388;6514.804555863332;6517.73929042833;6527.086207930894;6893.379595836399;6894.620795856276;6895.75864844728;6897.241303456616;6909.032735417046;6499;6510.08858759774;6512.6092434454085;6521.119648847345;6531.281559028503;3686.170611612419;3725.5529336479253;3725.683316918038;3730.0603686083628;3730.869419570302;6890.483213758888;7099.92900071003;7121;7133.643317834088;7134.571925684476;7011.263817299212;7022.227554968949;7022.964885175541;7028.753993610199;7034.859302813915;7084.504084714021;7099.3965512930945;7104.7158113675905;7108.68010939509;7116.181639111362;6900.689468973807;6901.344372284625;6908.3437073477935;6913.308669133046;6914.135733033371;6594.604323740591;6788.864222715617;6799.5920244785475;6861.108055952894;6868.965655171693;7028.0863487746265;7107.466939979418;7125.964370178116;7126.679299431642;7126.824074027727;4827.08285425768;4868.4157901050685;4875.268709693574;4884.023195361013;4890.413150421972;6839.350261725128;6843.931560684329;6849.315068493111;6855.07456493367;6861.4853885957755;6540.313267107075;6642.634655094016;6673.933260667525;6729.0579318894415;6731.798046058626;6620;6680.098186744727;6684.16447944007;6686.866262674816;6694.698738556874;6528.249251336157;6558.344165583403;6571.277159512545;6576.473882089325;6579.703913324008;6699.698513566804;6735.4611631070375;6747.325267473409;6752.122224110834;6755.392014718503;6444.355564443706;6561.442277406474;6569.113169722217;6589.143411356493;6589.835254118494 08:33:31 INFO - PROCESS | 2588 | |5;yui.html;805.9597020148991;852.364988083878;886.3479585709254;886.9888327306869;943.1370296178997;15178.696426071485;15500.689986200283;15511.457099001536;15512.61218469536;15519.068855868656;14684.632884177901;14741.336639851206;14756.926215368909;14763.557093287218;14768.556943291691;728.0717085715702;861.6553378648528;881.7090360181157;886.1227384888946;888.6711916590871;887.041994645781;891.5586784541629;893.0890491698464;895.154079394972;895.2793001633682;938.779386844091;939.2861425316775;940.2571968145191;941.0542404883083;941.2752180820764;756.2626439221742;908.9091090890925;913;918.8300164469562;920.6225447566466;679.9490038247102;680.0852852912824;680.1124532485105;682.2597481732327;683.962382068986;15287.388504459808;15531;15672.529824105295;15673.686526269525;15675;15175.392984280616;15222.314995825103;15342.463013794575;15379.077255364602;15476.458323958608;11902.226355286964;12158.331291778948;12168.81746773799;12313.199642023239;12490;4117.670586353084;4154.626083652455;4169.520505141917;4180.958190418088;4224.134052519226;52074.47925520734;52230.21654675145;52279;52663.736681316346;53134.468655313336;10650.147988160928;10685.57257709683;10707.411092389993;10750.462476876124;10827.891721082846;20436.795632043788;20945;21026.57946841085;21035.68446473304;21071.26250581222;8997.685081022133;9014.23379012778;9015;9075.909240907506;9203.033681463483;5161.561267292247;5226.817061402832;5248.685078895279;5284.128118860345;5336.17289320156;3581.068922080278;3670;3673.577538583044;3674.0998455378603;3681.1901381695984;666.1772710702279;675.5001299038775;684.5824047331124;697.5744795674634;732.6922692469176;717.7794567940476;817.1705718695529;823.7899335669485;833.0919297965247;836.3184005035877;9758.804823903482;9771.951140244395;9878;9950.601975921027;10058.145057670034;685.1504134872722;741.6514238307986;745.7054463486892;825.9834803303901;859.6948083430292;4643.2802915548145;4715.669903106818;4749.928751068736;4781.760911954389;4822.624411859934;66063.33936660572;66245;66639;66888.33111668918;67247.66376168087;57535.71232143813;58824;59080;59241.70379148163;59669.403305966385;52574.47425525696;54107.18839217415;54357.45642543603;54370.72814635901;54849.45150548523;9580.329376943548;9647.469389183661;9729.075737804897;9751.658691945748;9812.950935245279;38153.61846381501;38310.80844595759;39184.21631567296;40140.3978940322;40769;44238;44493.55506445024;47624.28563571619;49751.25373119478;50604.74697626488;11520.251183673034;11554.248973816675;11667.066634669036;11849.407529623311;12024.819627705416;12448.443944506937;12651.430685619353;12665.746685066431;12931.482740690268;13853.030287879752;11066.170037247077;13371.53199638008;13400.329983500591;13687.726245475234;13806.447742090204;12763.680907977376;13041.282729449591;13097.083204175617;13229.40467678976;13507.527236546674;12852.036097292927;12865.549705760253;12881.742365152832;12947.352632368533;13270.601881943558;11133.832992504957;11232.943835280772;11481.425928703698;11669.533218671158;11713.590024349107;11475.713107172387;11561.768764624492;11804.17370784037;11825.645230643095;11965.222260553384 08:33:31 INFO - PROCESS | 2588 | __end_tp_report 08:33:31 INFO - PROCESS | 2588 | __start_cc_report 08:33:31 INFO - PROCESS | 2588 | _x_x_mozilla_cycle_collect,852 08:33:31 INFO - PROCESS | 2588 | __end_cc_report 08:33:31 INFO - PROCESS | 2588 | __startTimestamp1464622411223__endTimestamp 08:33:31 INFO - PROCESS | 2588 | 08:33:31 INFO - PROCESS | 2588 | ------- Summary: start ------- 08:33:31 INFO - PROCESS | 2588 | Number of tests: 6 08:33:31 INFO - PROCESS | 2588 | 08:33:31 INFO - PROCESS | 2588 | [#0] dojo.html Cycles:165 Average:5472.00 Median:5672.38 stddev:602.61 (10.6%) stddev-sans-first:579.98 08:33:31 INFO - PROCESS | 2588 | Values: 3304.7 3358.9 3364.6 3370.1 3402.1 5438.8 5445.6 5457.9 5458.9 5484.0 5481.9 5499.3 5518.1 5535.0 5545.7 4861.8 4993.7 5106.8 5158.5 5195.2 4921.1 5010.9 5022.3 5023.1 5023.7 5005.5 5046.7 5059.5 5070.4 5093.3 5112.1 5126.6 5128.7 5137.3 5143.3 4852.8 4907.9 4967.7 5024.4 5051.7 5348.6 5388.2 5391.5 5391.8 5407.5 5843.3 5859.8 5861.1 5863.6 5869.7 5900.7 5923.2 5955.8 5978.9 6011.7 5509.7 5526.3 5553.6 5555.9 5583.4 5895.6 6067.3 6075.5 6077.6 6084.9 5735.9 5794.3 5795.3 5810.7 5817.8 5841.6 5842.8 5843.2 5847.4 5848.3 5717.6 5784.3 5825.2 5826.9 5835.0 5867.5 5875.3 5875.9 5913.2 5916.1 4478.1 4482.6 4483.6 4489.7 4509.2 3948.9 3951.6 4034.9 4036.1 4078.3 5581.7 5596.1 5604.7 5610.7 5626.0 5857.0 5857.9 5859.7 5859.9 5868.1 5451.6 5581.4 5597.1 5635.9 5645.1 4919.4 4950.0 4950.1 4953.7 4980.5 6043.5 6094.8 6099.1 6099.1 6103.1 5751.8 5839.5 5885.8 5898.5 5907.9 6133.6 6153.5 6153.8 6159.7 6163.7 5671.7 5862.0 5867.3 5868.2 5871.6 5863.4 5918.9 5921.9 5951.7 5970.5 5772.4 5779.5 5782.4 5782.7 5786.4 5471.7 5753.5 5753.6 5754.7 5768.5 5647.3 5669.3 5672.4 5674.1 5719.7 5776.6 5781.6 5784.6 5788.7 5788.9 5523.4 5604.7 5654.1 5695.1 5710.3 08:33:31 INFO - PROCESS | 2588 | 08:33:31 INFO - PROCESS | 2588 | [#1] ext.html Cycles:180 Average:57658.76 Median:39108.51 stddev:111709.79 (285.6%) stddev-sans-first:111941.02 08:33:31 INFO - PROCESS | 2588 | Values: 599.0 648.9 656.4 664.0 672.0 31562.4 32230.5 32317.7 32324.2 32328.7 39136.0 39926.0 39932.0 39972.8 39973.0 8721.0 8874.1 8885.6 8886.5 8891.5 8007.2 8655.3 8771.7 8796.9 10580.4 10485.5 10570.9 10582.1 10585.7 10589.9 10384.0 10448.5 10450.5 10468.7 10473.6 8002.2 10221.7 10309.7 10376.3 10378.5 40330.4 40628.0 40705.2 40881.0 40883.4 3848.9 3861.7 3903.5 3937.7 3950.3 33045.3 33472.3 33834.3 34173.0 34175.7 4586.6 4628.3 4691.0 4702.6 4719.1 316056.0 316120.0 317548.0 319305.4 319775.0 39368.8 65796.0 66769.7 66854.7 66870.0 38814.2 39102.6 39114.4 39129.2 39192.0 16941.0 16994.5 17062.6 17143.5 17156.3 14467.2 14508.6 14554.3 14559.2 14559.9 8785.2 8953.8 9367.5 9445.7 9511.7 3561.5 3655.7 3696.9 3712.6 3714.6 1078.4 1104.1 1133.7 1146.5 1266.2 31165.5 31499.7 31577.8 31975.7 32479.4 1207.4 1238.0 1243.9 1257.1 1295.4 17531.8 17691.6 17830.8 18041.9 18147.0 496103.0 499667.0 501226.0 501447.0 502158.0 61333.1 62090.4 62095.4 62131.0 62192.4 1360.4 1383.2 1544.8 1599.7 1604.5 30593.4 33040.0 33121.8 33257.3 33312.0 48197.5 57912.7 59608.0 59900.0 59901.0 425358.0 426156.0 428381.0 428905.0 428906.0 39236.4 45730.0 46010.5 46290.8 46341.5 44202.6 44437.0 44858.0 45031.0 45207.8 36259.3 39643.6 40383.2 41263.6 42109.6 39612.4 39945.6 40296.8 40556.8 40814.4 41656.4 41686.0 41856.8 43492.3 44658.1 32071.8 34485.5 36122.5 36330.2 36540.0 28219.7 28655.3 28832.6 28856.3 29017.0 08:33:31 INFO - PROCESS | 2588 | 08:33:31 INFO - PROCESS | 2588 | [#2] jquery.html Cycles:180 Average:28506.98 Median:2164.25 stddev:79635.64 (3679.6%) stddev-sans-first:79831.13 08:33:31 INFO - PROCESS | 2588 | Values: 427.6 428.7 433.9 435.2 435.8 18587.0 19110.6 19112.7 19285.8 19946.3 12489.4 12810.8 13204.6 19866.3 19953.5 5311.8 5416.4 5425.6 5466.0 5477.6 5720.1 5784.4 5826.2 5855.2 5865.8 5747.0 5789.1 5790.2 5799.3 5800.9 5672.9 5776.2 5810.1 5815.4 5818.7 5182.5 5222.6 5225.2 5230.4 5238.4 13755.1 13978.9 13984.0 14121.6 14123.2 2335.2 2515.8 2542.6 2771.0 2858.9 10656.7 10943.4 11727.2 13870.4 15242.2 2020.9 2031.8 2060.6 2127.5 2201.0 75604.0 76436.6 77121.6 77571.2 77668.2 11202.3 11250.3 11257.4 11373.9 11742.6 15623.5 15646.9 15740.1 16001.4 16081.4 8782.6 8848.0 8932.9 8945.0 8972.4 8892.4 8960.1 9042.0 9076.8 9112.8 4812.6 4819.3 4856.9 4872.4 4907.2 1947.2 1960.9 2006.0 2023.7 2035.9 917.8 994.7 1026.3 1027.9 1040.8 18457.4 18885.9 19591.7 19900.6 19930.9 1024.5 1027.6 1093.0 1114.3 1147.4 10844.9 11430.8 11454.9 11530.9 11565.8 476582.0 478231.0 481562.0 488902.0 490887.0 89492.6 90110.0 92965.5 93977.5 94976.0 1056.8 1064.7 1076.4 1081.2 1093.2 17187.7 17294.7 17358.7 17360.1 17409.4 38938.8 39430.4 40068.2 40145.8 40504.4 57110.4 57117.4 57343.1 57490.1 57572.1 8766.6 8912.4 8972.4 8992.6 9058.5 13026.0 13402.7 13610.6 13647.2 13845.4 8564.8 11825.6 12131.6 12145.9 12630.7 11538.5 11557.4 11720.5 11769.8 12011.9 12036.3 12324.4 12359.8 12468.0 12657.4 8805.8 8820.6 8858.3 8871.2 9225.9 11918.0 11968.2 12062.4 12298.9 12459.1 08:33:31 INFO - PROCESS | 2588 | 08:33:31 INFO - PROCESS | 2588 | [#3] mootools.html Cycles:180 Average:5640.33 Median:4838.50 stddev:3123.49 (64.6%) stddev-sans-first:3115.34 08:33:31 INFO - PROCESS | 2588 | Values: 1315.4 1497.5 1566.7 1751.9 1875.1 7278.7 8027.8 8135.7 8148.2 8159.9 8031.6 8182.2 8182.9 8191.3 8209.6 2063.7 2078.5 2384.6 2432.6 2454.8 2396.6 2402.1 2405.1 2406.7 2407.1 2376.4 2386.0 2412.1 2427.7 2429.9 2049.3 2087.3 2369.7 2397.9 2414.7 2368.9 2391.3 2395.0 2396.0 2403.9 8065.8 8140.7 8141.1 8146.8 8147.9 5278.5 5292.5 5349.5 5460.5 5481.2 3529.1 3534.5 3563.1 3572.0 3635.4 1141.6 1172.5 1185.2 1189.2 1209.7 12194.8 12202.3 12204.6 12206.9 12217.7 4732.7 4761.2 4838.0 4840.2 4841.8 10379.4 10399.7 10405.8 10406.9 10429.5 5418.6 5419.6 5450.6 5451.9 5452.5 4233.6 4765.8 4837.9 4839.1 4849.3 4130.3 4144.9 4169.3 4210.6 4214.1 1295.8 1299.0 1351.9 1356.9 1380.3 1067.1 1078.7 1085.5 1107.9 1114.7 5908.0 5971.9 5986.1 6052.5 6113.9 468.4 472.9 473.4 476.1 477.3 4175.6 4205.1 4212.2 4214.6 4278.8 10338.2 10670.6 10786.4 10861.5 10873.4 10195.8 10618.1 10633.1 10633.9 10644.5 8020.3 8022.8 8055.7 8152.7 8188.5 5722.7 5783.2 5827.3 5867.7 5903.5 9026.3 9212.0 9232.1 9339.7 9355.4 9252.7 9387.0 9528.0 9540.2 9560.0 6850.9 7379.9 7435.0 7621.4 7757.7 7858.1 7868.5 7896.9 7943.5 7952.8 7022.8 7335.4 7363.7 7390.2 7467.6 7179.0 7179.2 7223.8 7248.7 7379.8 6587.7 6628.8 6659.1 6662.6 6672.6 4939.7 4958.8 4987.2 5107.4 5113.8 5081.1 5086.3 5090.1 5096.6 5196.0 08:33:31 INFO - PROCESS | 2588 | 08:33:31 INFO - PROCESS | 2588 | [#4] prototype.html Cycles:180 Average:5591.11 Median:6404.47 stddev:1672.19 (26.1%) stddev-sans-first:1629.84 08:33:31 INFO - PROCESS | 2588 | Values: 343.7 347.4 368.0 369.1 371.1 6243.6 6256.9 6281.7 6281.8 6337.2 6271.0 6271.1 6271.6 6272.1 6279.8 4564.7 4692.6 4779.3 4799.3 4807.2 4786.6 4813.5 4835.2 4843.5 4848.4 4613.7 4829.4 4836.2 4841.0 4844.5 4662.7 4745.8 4751.2 4761.0 4805.1 4242.1 4242.8 4249.9 4255.1 4256.6 6018.5 6024.4 6035.6 6038.7 6041.5 5589.9 5590.0 5593.7 5597.5 5601.6 6457.6 6591.2 6597.5 6598.0 6601.5 4683.7 4691.0 4692.6 4700.9 4702.8 6870.9 6945.0 6948.8 6952.4 6953.4 4799.3 4803.5 4804.2 4805.2 4806.9 4845.9 4862.2 4863.4 4865.3 4869.9 5554.3 5555.9 5559.2 5572.9 5573.3 6452.1 6628.2 6631.6 6641.8 6644.7 1692.2 1721.3 1723.3 1723.5 1727.1 1046.4 1137.6 1150.9 1161.3 1176.6 6364.6 6505.4 6514.8 6517.7 6527.1 6893.4 6894.6 6895.8 6897.2 6909.0 6499.0 6510.1 6512.6 6521.1 6531.3 3686.2 3725.6 3725.7 3730.1 3730.9 6890.5 7099.9 7121.0 7133.6 7134.6 7011.3 7022.2 7023.0 7028.8 7034.9 7084.5 7099.4 7104.7 7108.7 7116.2 6900.7 6901.3 6908.3 6913.3 6914.1 6594.6 6788.9 6799.6 6861.1 6869.0 7028.1 7107.5 7126.0 7126.7 7126.8 4827.1 4868.4 4875.3 4884.0 4890.4 6839.4 6843.9 6849.3 6855.1 6861.5 6540.3 6642.6 6673.9 6729.1 6731.8 6620.0 6680.1 6684.2 6686.9 6694.7 6528.2 6558.3 6571.3 6576.5 6579.7 6699.7 6735.5 6747.3 6752.1 6755.4 6444.4 6561.4 6569.1 6589.1 6589.8 08:33:31 INFO - PROCESS | 2588 | 08:33:31 INFO - PROCESS | 2588 | [#5] yui.html Cycles:180 Average:15677.77 Median:26187.11 stddev:18005.73 (68.8%) stddev-sans-first:18021.61 08:33:31 INFO - PROCESS | 2588 | Values: 806.0 852.4 886.3 887.0 943.1 15178.7 15500.7 15511.5 15512.6 15519.1 14684.6 14741.3 14756.9 14763.6 14768.6 728.1 861.7 881.7 886.1 888.7 887.0 891.6 893.1 895.2 895.3 938.8 939.3 940.3 941.1 941.3 756.3 908.9 913.0 918.8 920.6 679.9 680.1 680.1 682.3 684.0 15287.4 15531.0 15672.5 15673.7 15675.0 15175.4 15222.3 15342.5 15379.1 15476.5 11902.2 12158.3 12168.8 12313.2 12490.0 4117.7 4154.6 4169.5 4181.0 4224.1 52074.5 52230.2 52279.0 52663.7 53134.5 10650.1 10685.6 10707.4 10750.5 10827.9 20436.8 20945.0 21026.6 21035.7 21071.3 8997.7 9014.2 9015.0 9075.9 9203.0 5161.6 5226.8 5248.7 5284.1 5336.2 3581.1 3670.0 3673.6 3674.1 3681.2 666.2 675.5 684.6 697.6 732.7 717.8 817.2 823.8 833.1 836.3 9758.8 9772.0 9878.0 9950.6 10058.1 685.2 741.7 745.7 826.0 859.7 4643.3 4715.7 4749.9 4781.8 4822.6 66063.3 66245.0 66639.0 66888.3 67247.7 57535.7 58824.0 59080.0 59241.7 59669.4 52574.5 54107.2 54357.5 54370.7 54849.5 9580.3 9647.5 9729.1 9751.7 9813.0 38153.6 38310.8 39184.2 40140.4 40769.0 44238.0 44493.6 47624.3 49751.3 50604.7 11520.3 11554.2 11667.1 11849.4 12024.8 12448.4 12651.4 12665.7 12931.5 13853.0 11066.2 13371.5 13400.3 13687.7 13806.4 12763.7 13041.3 13097.1 13229.4 13507.5 12852.0 12865.5 12881.7 12947.4 13270.6 11133.8 11232.9 11481.4 11669.5 11713.6 11475.7 11561.8 11804.2 11825.6 11965.2 08:33:31 INFO - PROCESS | 2588 | -------- Summary: end -------- 08:33:31 INFO - PROCESS | 2588 | 08:33:31 INFO - TEST-INFO | 2588: exit 0 08:33:31 INFO - TEST-OK | dromaeo_css | took 1110739ms 08:33:31 INFO - TEST-START | kraken 08:33:31 INFO - operating with platform_type : linux_ 08:33:31 INFO - Initialising browser for kraken test... 08:33:31 INFO - TEST-INFO | started process 2882 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIv5Cas/profile http://localhost:52532/getInfo.html) 08:33:35 INFO - PROCESS | 2882 | __metrics Screen width/height:1600/1200 08:33:35 INFO - PROCESS | 2882 | colorDepth:24 08:33:35 INFO - PROCESS | 2882 | Browser inner width/height: 1024/697 08:33:35 INFO - PROCESS | 2882 | __metrics 08:33:36 ERROR - PROCESS | 2882 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:33:37 INFO - TEST-INFO | 2882: exit 0 08:33:37 INFO - Browser initialized. 08:33:37 INFO - Running cycle 1/1 for kraken test... 08:33:37 INFO - TEST-INFO | started process 2974 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIv5Cas/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:33:49 INFO - PROCESS | 2974 | RSS: Main: 142069760 08:33:49 INFO - PROCESS | 2974 | 08:33:51 INFO - PROCESS | 2974 | Cycle 1(1): loaded http://localhost:52532/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52532/tests/kraken/driver.html?testName=audio-beat-detection) 08:33:52 INFO - PROCESS | 2974 | RSS: Main: 196861952 08:33:52 INFO - PROCESS | 2974 | 08:33:54 INFO - PROCESS | 2974 | Cycle 1(1): loaded http://localhost:52532/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52532/tests/kraken/driver.html?testName=audio-dft) 08:33:55 INFO - PROCESS | 2974 | RSS: Main: 181420032 08:33:55 INFO - PROCESS | 2974 | 08:33:58 INFO - PROCESS | 2974 | Cycle 1(1): loaded http://localhost:52532/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52532/tests/kraken/driver.html?testName=audio-fft) 08:33:59 INFO - PROCESS | 2974 | RSS: Main: 272306176 08:33:59 INFO - PROCESS | 2974 | 08:34:01 INFO - PROCESS | 2974 | Cycle 1(1): loaded http://localhost:52532/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52532/tests/kraken/driver.html?testName=audio-oscillator) 08:34:01 INFO - PROCESS | 2974 | RSS: Main: 178839552 08:34:01 INFO - PROCESS | 2974 | 08:34:03 INFO - PROCESS | 2974 | Cycle 1(1): loaded http://localhost:52532/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52532/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:34:04 INFO - PROCESS | 2974 | RSS: Main: 177037312 08:34:04 INFO - PROCESS | 2974 | 08:34:07 INFO - PROCESS | 2974 | Cycle 1(1): loaded http://localhost:52532/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52532/tests/kraken/driver.html?testName=imaging-darkroom) 08:34:07 INFO - PROCESS | 2974 | RSS: Main: 211017728 08:34:07 INFO - PROCESS | 2974 | 08:34:11 INFO - PROCESS | 2974 | Cycle 1(1): loaded http://localhost:52532/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52532/tests/kraken/driver.html?testName=imaging-desaturate) 08:34:11 INFO - PROCESS | 2974 | RSS: Main: 211488768 08:34:11 INFO - PROCESS | 2974 | 08:34:14 INFO - PROCESS | 2974 | Cycle 1(1): loaded http://localhost:52532/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52532/tests/kraken/driver.html?testName=json-parse-financial) 08:34:15 INFO - PROCESS | 2974 | RSS: Main: 211181568 08:34:15 INFO - PROCESS | 2974 | 08:34:16 INFO - PROCESS | 2974 | Cycle 1(1): loaded http://localhost:52532/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52532/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:34:17 INFO - PROCESS | 2974 | RSS: Main: 189575168 08:34:17 INFO - PROCESS | 2974 | 08:34:19 INFO - PROCESS | 2974 | Cycle 1(1): loaded http://localhost:52532/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52532/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:34:19 INFO - PROCESS | 2974 | RSS: Main: 193617920 08:34:19 INFO - PROCESS | 2974 | 08:34:21 INFO - PROCESS | 2974 | Cycle 1(1): loaded http://localhost:52532/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52532/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:34:22 INFO - PROCESS | 2974 | RSS: Main: 206852096 08:34:22 INFO - PROCESS | 2974 | 08:34:24 INFO - PROCESS | 2974 | Cycle 1(1): loaded http://localhost:52532/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52532/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:34:25 INFO - PROCESS | 2974 | RSS: Main: 213336064 08:34:25 INFO - PROCESS | 2974 | 08:34:28 INFO - PROCESS | 2974 | Cycle 1(1): loaded http://localhost:52532/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52532/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:34:28 INFO - PROCESS | 2974 | RSS: Main: 209846272 08:34:28 INFO - PROCESS | 2974 | 08:34:30 INFO - PROCESS | 2974 | Cycle 1(1): loaded http://localhost:52532/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52532/tests/kraken/driver.html?testName=ai-astar) 08:34:30 INFO - PROCESS | 2974 | RSS: Main: 273453056 08:34:30 INFO - PROCESS | 2974 | 08:34:30 INFO - PROCESS | 2974 | __start_tp_report 08:34:30 INFO - PROCESS | 2974 | _x_x_mozilla_page_load 08:34:30 INFO - PROCESS | 2974 | _x_x_mozilla_page_load_details 08:34:30 INFO - PROCESS | 2974 | |i|pagename|runs| 08:34:30 INFO - PROCESS | 2974 | |0;ai-astar;110;113;112;111;111;109;105;110;110;109 08:34:30 INFO - PROCESS | 2974 | |1;audio-beat-detection;156;132;161;173;126;161;154;129;180;136 08:34:30 INFO - PROCESS | 2974 | |2;audio-dft;161;161;161;161;158;160;160;159;162;160 08:34:30 INFO - PROCESS | 2974 | |3;audio-fft;77;78;77;175;73;75;77;77;155;75 08:34:30 INFO - PROCESS | 2974 | |4;audio-oscillator;92;93;154;92;92;92;147;92;93;160 08:34:30 INFO - PROCESS | 2974 | |5;imaging-gaussian-blur;117;118;117;117;117;117;116;116;117;117 08:34:30 INFO - PROCESS | 2974 | |6;imaging-darkroom;146;145;145;146;145;145;145;146;145;146 08:34:30 INFO - PROCESS | 2974 | |7;imaging-desaturate;95;94;95;94;95;95;95;96;94;95 08:34:30 INFO - PROCESS | 2974 | |8;json-parse-financial;54;55;54;53;61;54;56;77;53;53 08:34:30 INFO - PROCESS | 2974 | |9;json-stringify-tinderbox;59;60;60;60;60;59;59;59;59;59 08:34:30 INFO - PROCESS | 2974 | |10;stanford-crypto-aes;72;72;80;73;81;73;74;81;80;73 08:34:30 INFO - PROCESS | 2974 | |11;stanford-crypto-ccm;120;116;112;115;109;111;114;114;130;127 08:34:30 INFO - PROCESS | 2974 | |12;stanford-crypto-pbkdf2;160;162;159;161;160;160;157;161;162;157 08:34:30 INFO - PROCESS | 2974 | |13;stanford-crypto-sha256-iterative;69;69;68;67;70;68;65;67;67;64 08:34:30 INFO - PROCESS | 2974 | __end_tp_report 08:34:30 INFO - PROCESS | 2974 | __start_cc_report 08:34:30 INFO - PROCESS | 2974 | _x_x_mozilla_cycle_collect,1583 08:34:30 INFO - PROCESS | 2974 | __end_cc_report 08:34:30 INFO - PROCESS | 2974 | __startTimestamp1464622470575__endTimestamp 08:34:30 INFO - PROCESS | 2974 | 08:34:30 INFO - PROCESS | 2974 | ------- Summary: start ------- 08:34:30 INFO - PROCESS | 2974 | Number of tests: 14 08:34:30 INFO - PROCESS | 2974 | 08:34:30 INFO - PROCESS | 2974 | [#0] ai-astar Cycles:10 Average:110.00 Median:110.50 stddev:2.16 (2.0%) stddev-sans-first:2.29 08:34:30 INFO - PROCESS | 2974 | Values: 110.0 113.0 112.0 111.0 111.0 109.0 105.0 110.0 110.0 109.0 08:34:30 INFO - PROCESS | 2974 | 08:34:30 INFO - PROCESS | 2974 | [#1] audio-beat-detection Cycles:10 Average:150.80 Median:158.50 stddev:19.01 (12.0%) stddev-sans-first:20.07 08:34:30 INFO - PROCESS | 2974 | Values: 156.0 132.0 161.0 173.0 126.0 161.0 154.0 129.0 180.0 136.0 08:34:30 INFO - PROCESS | 2974 | 08:34:30 INFO - PROCESS | 2974 | [#2] audio-dft Cycles:10 Average:160.30 Median:161.00 stddev:1.16 (0.7%) stddev-sans-first:1.20 08:34:30 INFO - PROCESS | 2974 | Values: 161.0 161.0 161.0 161.0 158.0 160.0 160.0 159.0 162.0 160.0 08:34:30 INFO - PROCESS | 2974 | 08:34:30 INFO - PROCESS | 2974 | [#3] audio-fft Cycles:10 Average:93.90 Median:77.00 stddev:37.80 (49.1%) stddev-sans-first:39.59 08:34:30 INFO - PROCESS | 2974 | Values: 77.0 78.0 77.0 175.0 73.0 75.0 77.0 77.0 155.0 75.0 08:34:30 INFO - PROCESS | 2974 | 08:34:30 INFO - PROCESS | 2974 | [#4] audio-oscillator Cycles:10 Average:110.70 Median:92.00 stddev:29.81 (32.4%) stddev-sans-first:30.84 08:34:30 INFO - PROCESS | 2974 | Values: 92.0 93.0 154.0 92.0 92.0 92.0 147.0 92.0 93.0 160.0 08:34:30 INFO - PROCESS | 2974 | 08:34:30 INFO - PROCESS | 2974 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 08:34:30 INFO - PROCESS | 2974 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 08:34:30 INFO - PROCESS | 2974 | 08:34:30 INFO - PROCESS | 2974 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 08:34:30 INFO - PROCESS | 2974 | Values: 146.0 145.0 145.0 146.0 145.0 145.0 145.0 146.0 145.0 146.0 08:34:30 INFO - PROCESS | 2974 | 08:34:30 INFO - PROCESS | 2974 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 08:34:30 INFO - PROCESS | 2974 | Values: 95.0 94.0 95.0 94.0 95.0 95.0 95.0 96.0 94.0 95.0 08:34:30 INFO - PROCESS | 2974 | 08:34:30 INFO - PROCESS | 2974 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:54.50 stddev:7.42 (13.6%) stddev-sans-first:7.79 08:34:30 INFO - PROCESS | 2974 | Values: 54.0 55.0 54.0 53.0 61.0 54.0 56.0 77.0 53.0 53.0 08:34:30 INFO - PROCESS | 2974 | 08:34:30 INFO - PROCESS | 2974 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:59.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 08:34:30 INFO - PROCESS | 2974 | Values: 59.0 60.0 60.0 60.0 60.0 59.0 59.0 59.0 59.0 59.0 08:34:30 INFO - PROCESS | 2974 | 08:34:30 INFO - PROCESS | 2974 | [#10] stanford-crypto-aes Cycles:10 Average:75.90 Median:77.00 stddev:4.01 (5.2%) stddev-sans-first:4.00 08:34:30 INFO - PROCESS | 2974 | Values: 72.0 72.0 80.0 73.0 81.0 73.0 74.0 81.0 80.0 73.0 08:34:30 INFO - PROCESS | 2974 | 08:34:30 INFO - PROCESS | 2974 | [#11] stanford-crypto-ccm Cycles:10 Average:116.80 Median:115.50 stddev:6.88 (6.0%) stddev-sans-first:7.20 08:34:30 INFO - PROCESS | 2974 | Values: 120.0 116.0 112.0 115.0 109.0 111.0 114.0 114.0 130.0 127.0 08:34:30 INFO - PROCESS | 2974 | 08:34:30 INFO - PROCESS | 2974 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.90 Median:160.50 stddev:1.79 (1.1%) stddev-sans-first:1.90 08:34:30 INFO - PROCESS | 2974 | Values: 160.0 162.0 159.0 161.0 160.0 160.0 157.0 161.0 162.0 157.0 08:34:30 INFO - PROCESS | 2974 | 08:34:30 INFO - PROCESS | 2974 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:68.00 stddev:1.84 (2.7%) stddev-sans-first:1.86 08:34:30 INFO - PROCESS | 2974 | Values: 69.0 69.0 68.0 67.0 70.0 68.0 65.0 67.0 67.0 64.0 08:34:30 INFO - PROCESS | 2974 | -------- Summary: end -------- 08:34:30 INFO - PROCESS | 2974 | 08:34:31 INFO - TEST-INFO | 2974: exit 0 08:34:31 INFO - TEST-OK | kraken | took 59562ms 08:34:31 INFO - SUITE-END | took 1170s 08:34:31 INFO - Completed test suite (00:19:30) 08:34:31 INFO - javascript benchmark 08:34:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3304.702576768091, 3358.88243911463, 3364.6298907120226, 3370.1237678203665, 3402.064432281122, 5438.7824487020525, 5445.564354851612, 5457.863553411166, 5458.9454105458935, 5483.972580137103, 5481.890362192754, 5499.257600223968, 5518.089515229993, 5535.0, 5545.722713864301, 4861.805527778884, 4993.725345106018, 5106.795728170869, 5158.509941555546, 5195.168772996321, 4921.064997650435, 5010.924836127461, 5022.271770593262, 5023.14606516893, 5023.673461225027, 5005.54950054495, 5046.697198168122, 5059.468755780646, 5070.442251352349, 5093.26147708582, 5112.130937740593, 5126.5642420394315, 5128.743562821881, 5137.255098010767, 5143.254228136918, 4852.830150944736, 4907.8773030674165, 4967.652264341461, 5024.371953505812, 5051.747412629354, 5348.625596208267, 5388.164834450667, 5391.460853914617, 5391.81128660495, 5407.5133238008375, 5843.2695913010875, 5859.824205273849, 5861.062230043215, 5863.560232982543, 5869.706514674292, 5900.734466948998, 5923.229980102602, 5955.791547295824, 5978.940210597882, 6011.699415029275, 5509.669419834822, 5526.253955716007, 5553.6390134641115, 5555.944440555583, 5583.3858275589655, 5895.616784908967, 6067.271927368655, 6075.513958883367, 6077.604955677867, 6084.939150608526, 5735.856603584861, 5794.333651630117, 5795.275590551181, 5810.6513609183585, 5817.76728930838, 5841.620294680917, 5842.795502157489, 5843.152742852348, 5847.415258474119, 5848.298204215436, 5717.628354156966, 5784.334801497882, 5825.155352473867, 5826.854328641733, 5834.970825145932, 5867.501262392659, 5875.294964604275, 5875.9118613220835, 5913.201717768046, 5916.053431450947, 4478.149151661174, 4482.618977386894, 4483.55164483549, 4489.663275254304, 4509.1658043262105, 3948.881533553998, 3951.6443520082757, 4034.91930161401, 4036.1120553478186, 4078.3270760324212, 5581.7209139543675, 5596.076647353141, 5604.663720176803, 5610.691411972299, 5625.971870140705, 5857.0335894577765, 5857.882842343214, 5859.736311865976, 5859.882802343929, 5868.061110222344, 5451.591130665216, 5581.413951535112, 5597.132444471114, 5635.887282254332, 5645.125005624135, 4919.385076865392, 4949.950500494949, 4950.133726597831, 4953.678010929278, 4980.5019498049905, 6043.48630366415, 6094.786682466181, 6099.054646529795, 6099.115628233882, 6103.084537319349, 5751.769929202785, 5839.5036421904615, 5885.764569417175, 5898.469137777621, 5907.852303692442, 6133.6319820810895, 6153.507719382349, 6153.84615384619, 6159.6612186330185, 6163.660998645118, 5671.744771485211, 5861.9706901466925, 5867.266591676041, 5868.2077919482035, 5871.588988770916, 5863.384344643751, 5918.852028699317, 5921.911171332347, 5951.732172052355, 5970.462658360769, 5772.422757724194, 5779.537636988946, 5782.3639399666845, 5782.739776709974, 5786.42135786418, 5471.726264484973, 5753.482186603226, 5753.626014309057, 5754.683492407958, 5768.451997060272, 5647.265855438766, 5669.319681638065, 5672.376038635664, 5674.06377947634, 5719.714014299185, 5776.56675749312, 5781.566382521243, 5784.566157538117, 5788.739506722123, 5788.913166302593, 5523.4200408956485, 5604.663720176803, 5654.06707893193, 5695.0603150481365, 5710.2576665033275], "value": 5433.4025444115505, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [598.9940100598996, 648.9033533328671, 656.3862788292944, 664.0, 671.9932800671992, 31562.368752624934, 32230.516542251884, 32317.67682323176, 32324.19189520263, 32328.67671323286, 39136.0, 39926.0, 39932.0, 39972.80013599935, 39973.0, 8720.95639521803, 8874.068222836573, 8885.600147993357, 8886.46681199127, 8891.466512009269, 8007.1992800720045, 8655.264302534291, 8771.736847894541, 8796.912030879705, 10580.4180770058, 10485.475726213697, 10570.947145264263, 10582.100521455686, 10585.682429527127, 10589.947050264738, 10384.0, 10448.52981615829, 10450.47747612624, 10468.68593942183, 10473.633422830164, 8002.239787220205, 10221.744456388575, 10309.74225644365, 10376.273660843744, 10378.532966016548, 40330.395044074365, 40628.0, 40705.18589628191, 40881.0, 40883.386749198784, 3848.8589599700713, 3861.7296789224765, 3903.4535165076913, 3937.6652984496354, 3950.308695978221, 33045.339093218245, 33472.3305533888, 33834.32331353384, 34173.0, 34175.6582434175, 4586.610138138262, 4628.3288923105965, 4690.95309046912, 4702.6002789762915, 4719.10337035962, 316056.0, 316120.0, 317548.0, 319305.40347298345, 319775.0, 39368.80315598404, 65796.0, 66769.66615166893, 66854.66572667105, 66870.0, 38814.22371552553, 39102.608973910465, 39114.413283800764, 39129.217415651525, 39192.0, 16941.0, 16994.49016529506, 17062.573435664206, 17143.485695429157, 17156.31374745021, 14467.204303763394, 14508.637284067772, 14554.27228638585, 14559.19924404168, 14559.85440145585, 8785.165409286108, 8953.776155596031, 9367.484788336707, 9445.669401570913, 9511.714648560554, 3561.4835848802295, 3655.6527129922615, 3696.9445458318146, 3712.5916149223563, 3714.57282412526, 1078.4176544665793, 1104.1111904916459, 1133.6995696140364, 1146.48408216303, 1266.1643315411784, 31165.532517012263, 31499.685003150134, 31577.842110789297, 31975.680243197272, 32479.350412991607, 1207.372166473429, 1237.9938100309441, 1243.8569564500017, 1257.1451413039222, 1295.4105881823748, 17531.824681753274, 17691.646167076586, 17830.821691783174, 18041.909790450965, 18147.0, 496103.0, 499667.0, 501226.0, 501446.9855301473, 502158.0, 61333.08000379998, 62090.37909620936, 62095.37904620896, 62131.0, 62192.37807621956, 1360.3878254785188, 1383.2253937794867, 1544.8068991376078, 1599.7440409534418, 1604.4705247268373, 30593.388132237676, 33040.008799736046, 33121.83439082789, 33257.334853303284, 33312.0, 48197.51802481931, 57912.710436447545, 59608.0, 59900.0, 59901.0, 425358.0, 426156.0, 428381.0, 428905.0, 428906.0, 39236.41145382765, 45730.0, 46010.53989460196, 46290.76854615705, 46341.53658463372, 44202.55797442113, 44437.0, 44858.0, 45031.0, 45207.773961129984, 36259.27481450409, 39643.603563965145, 40383.192336152526, 41263.587364127176, 42109.57890421057, 39612.40581391339, 39945.60054399419, 40296.798516007235, 40556.79721601373, 40814.387784183855, 41656.375154373316, 41686.0, 41856.79071604623, 43492.34761478517, 44658.10683786241, 32071.839640801645, 34485.482717759754, 36122.458163128096, 36330.18349082588, 36540.0, 28219.71780282171, 28655.283617909718, 28832.567511486926, 28856.278593035342, 29017.0], "value": 19794.273252187, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [427.57669906792285, 428.66349915316465, 433.89369604446915, 435.1970614216769, 435.7581542244054, 18587.0, 19110.617787644238, 19112.713309300372, 19285.807141928577, 19946.301879434224, 12489.375531223448, 12810.807837882416, 13204.626263433345, 19866.304679336226, 19953.501162470944, 5311.760970756306, 5416.404195538487, 5425.565954723613, 5466.0, 5477.616566840323, 5720.084786434171, 5784.421557844203, 5826.21346118275, 5855.23881895353, 5865.8240252792275, 5747.0, 5789.131630255453, 5790.189373487715, 5799.2750906136735, 5800.883982320351, 5672.858178545528, 5776.220210271602, 5810.070388737781, 5815.447532484407, 5818.679972601505, 5182.507661772125, 5222.63441559091, 5225.242339860737, 5230.424653288135, 5238.449962753933, 13755.10591811539, 13978.93010534951, 13984.021118521707, 14121.646958826008, 14123.223222722747, 2335.2060299498253, 2515.7735803777564, 2542.555052865741, 2771.0, 2858.857057147134, 10656.680299591024, 10943.398113103776, 11727.17909746318, 13870.375833087535, 15242.237888105661, 2020.9393718188478, 2031.7968203179712, 2060.6393881070903, 2127.4787677019076, 2201.020545857094, 75604.0, 76436.61781691112, 77121.61439192825, 77571.22428775753, 77668.22331776666, 11202.271852329572, 11250.268732532522, 11257.380844053656, 11373.943130284295, 11742.647720568397, 15623.53129406097, 15646.9217653911, 15740.134292614017, 16001.439949601941, 16081.35674573004, 8782.560871956377, 8848.0, 8932.910670893338, 8945.0, 8972.41679290844, 8892.421992570591, 8960.103989601119, 9042.0, 9076.773080672903, 9112.772180695536, 4812.5668689818085, 4819.3012013258585, 4856.902861942742, 4872.3909511311085, 4907.1657818171, 1947.2308438166845, 1960.9117589708496, 2005.9699104513445, 2023.6559784836318, 2035.8676686015658, 917.8439665256923, 994.7115336552318, 1026.2508368890751, 1027.8561001459802, 1040.7502199472071, 18457.353992610464, 18885.92254851965, 19591.706124408145, 19900.60198796016, 19930.90034549847, 1024.472396715692, 1027.5735569738474, 1093.0431836750854, 1114.2868564118971, 1147.437755499799, 10844.945775271231, 11430.771384572428, 11454.94272528632, 11530.94234528822, 11565.826512602318, 476582.0, 478231.0, 481562.0, 488902.0, 490887.0, 89492.5525372382, 90110.0, 92965.53517232371, 93977.530112349, 94976.0, 1056.7939251845817, 1064.723171975292, 1076.4241130995038, 1081.1837063017529, 1093.2019625673145, 17187.742183867, 17294.74057889158, 17358.73961890598, 17360.131993400533, 17409.390671326444, 38938.80530597329, 39430.408543872436, 40068.1986360277, 40145.79927100346, 40504.392434112924, 57110.42889571051, 57117.42882571121, 57343.139852901404, 57490.137647934476, 57572.1364179546, 8766.561671916252, 8912.420692654956, 8972.37193396456, 8992.59533320989, 9058.456492610465, 13026.0, 13402.731945360843, 13610.59168224955, 13647.181169129884, 13845.376958037114, 8564.828703426021, 11825.645230643095, 12131.636050918487, 12145.878541214475, 12630.747385052431, 11538.48076836561, 11557.42212889369, 11720.531178752753, 11769.764604708029, 12011.939940300243, 12036.338001410006, 12324.445399956845, 12359.752804943671, 12468.0, 12657.430415631134, 8805.823883522165, 8820.603072861864, 8858.291336693179, 8871.157240062184, 9225.907740922774, 11918.0, 11968.222065565711, 12062.396880155782, 12298.938505307417, 12459.127861050001], "value": 9294.696857690577, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1315.35547581685, 1497.5133081748434, 1566.7336552786028, 1751.8773685841995, 1875.1468082022682, 7278.708851645934, 8027.799305017377, 8135.7152499662525, 8148.225918537744, 8159.91840081599, 8031.558264295461, 8182.181781821815, 8182.91817081829, 8191.344692424606, 8209.6305666245, 2063.6698128299477, 2078.532330225702, 2384.606539920911, 2432.635104734291, 2454.791342735861, 2396.59257926153, 2402.0992127952018, 2405.0980882169188, 2406.74729153439, 2407.109369533275, 2376.370261880603, 2386.0217310902535, 2412.1316326122583, 2427.7329493755674, 2429.927102186937, 2049.3134799841996, 2087.279888438486, 2369.7393286738443, 2397.8681172535503, 2414.7343792182846, 2368.9170879019152, 2391.2587097999676, 2395.0180426025245, 2396.017632770573, 2403.903843846244, 8065.798355041171, 8140.674373025131, 8141.145179756099, 8146.75559733209, 8147.918520814835, 5278.47215278473, 5292.52367286946, 5349.545288650469, 5460.481254280837, 5481.150421684605, 3529.1177205698577, 3534.469829525566, 3563.055790215595, 3571.982140089283, 3635.3638113330326, 1141.6460897121835, 1172.5485688010092, 1185.211834130311, 1189.167582692119, 1209.7338585511172, 12194.81707774384, 12202.328871912041, 12204.633860984184, 12206.877931220663, 12217.694557636041, 4732.73969931657, 4761.166795810719, 4837.95162048375, 4840.160738919189, 4841.806327746921, 10379.377237365783, 10399.740006499747, 10405.791884162274, 10406.895931040593, 10429.530671119817, 5418.593605479605, 5419.647722897999, 5450.563954883679, 5451.890962180813, 5452.509274165344, 4233.597808208216, 4765.809367625326, 4837.927431088537, 4839.056384005155, 4849.2968519564465, 4130.318497447887, 4144.8756537303925, 4169.3120635094865, 4210.5578914214175, 4214.05183833635, 1295.8185853980451, 1298.9740205195844, 1351.8648135186402, 1356.891448684103, 1380.2684577173914, 1067.0823092140752, 1078.7087486378634, 1085.5115198160702, 1107.9113670906308, 1114.7046032801313, 5908.0, 5971.850703732354, 5986.102084687332, 6052.485538729169, 6113.877722445526, 468.41916024129836, 472.9219678753036, 473.3515084334484, 476.1476956248277, 477.2840738891662, 4175.603317684815, 4205.095904380573, 4212.220739163265, 4214.557471465513, 4278.764667943293, 10338.224633152544, 10670.573177072985, 10786.352818830896, 10861.511231994578, 10873.401962892116, 10195.847062293924, 10618.097461715686, 10633.096186824052, 10633.89366106329, 10644.467776611293, 8020.318272946748, 8022.75931722061, 8055.718049868226, 8152.673893044212, 8188.50868947865, 5722.713864306851, 5783.190353350618, 5827.3007239131575, 5867.735951882261, 5903.498202652822, 9026.323025773225, 9211.953940230256, 9232.076792320715, 9339.719808405758, 9355.4386736796, 9252.676156334495, 9386.95306523463, 9527.952360238154, 9540.189083927666, 9559.952200238955, 6850.8972365413565, 7379.926200737924, 7434.959105725311, 7621.428392870446, 7757.650905709143, 7858.0570331560575, 7868.488548244346, 7896.881546776918, 7943.4836735612, 7952.761417157494, 7022.789316320519, 7335.413166946525, 7363.705451781869, 7390.224026477357, 7467.551946883204, 7179.0, 7179.210556546206, 7223.783286501413, 7248.746293879689, 7379.8155046124275, 6587.703553340207, 6628.767993120217, 6659.067730517634, 6662.56693314933, 6672.633005184762, 4939.678920870132, 4958.776855041604, 4987.226979818134, 5107.41264754558, 5113.821016264413, 5081.136206844919, 5086.338775959101, 5090.109230884506, 5096.617753668564, 5196.038732834438], "value": 4519.373476625278, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.6700767263427, 347.3521881690646, 367.9595244523102, 369.0975564744202, 371.0778714893491, 6243.625382477049, 6256.906146407802, 6281.748730050798, 6281.842953926142, 6337.207849018872, 6270.9686451567795, 6271.059341098826, 6271.623702577848, 6272.059191121334, 6279.8116056518265, 4564.657650676196, 4692.554207350297, 4779.28310753388, 4799.3280940668155, 4807.182778927573, 4786.593139583139, 4813.542713442217, 4835.178019736635, 4843.515648435164, 4848.442429120643, 4613.746243956581, 4829.372181616385, 4836.177849765549, 4841.031793641268, 4844.539768721966, 4662.696924699883, 4745.786439610209, 4751.192297309466, 4760.976195119037, 4805.135075686375, 4242.087951090531, 4242.766647834368, 4249.893752656178, 4255.127698821734, 4256.59562341577, 6018.458338749533, 6024.397560243984, 6035.577509574332, 6038.667873266969, 6041.5468839837185, 5589.888202235973, 5590.0, 5593.664380137205, 5597.524210442118, 5601.60788744784, 6457.61254324742, 6591.242007169141, 6597.47220222381, 6598.0, 6601.504887133437, 4683.718976861399, 4691.038337140912, 4692.554207350297, 4700.929486057712, 4702.835400760991, 6870.896936545956, 6945.027696122547, 6948.756793512202, 6952.409045231161, 6953.374196322305, 4799.256115302133, 4803.471618122004, 4804.159272127434, 4805.207140821795, 4806.94247265601, 4845.903081938412, 4862.222044472867, 4863.367762190964, 4865.343178670834, 4869.878253043631, 5554.333479982347, 5555.944440555623, 5559.16612508127, 5572.888542229132, 5573.275474188411, 6452.1289625900845, 6628.204615446178, 6631.635260060743, 6641.767538136142, 6644.700988455531, 1692.1792930428733, 1721.28566644841, 1723.2676112652073, 1723.4571110100528, 1727.1278004607593, 1046.4453839465095, 1137.612113221868, 1150.913681473893, 1161.2509931094396, 1176.5764324843049, 6364.586301890362, 6505.41451269388, 6514.804555863332, 6517.73929042833, 6527.086207930894, 6893.379595836399, 6894.620795856276, 6895.75864844728, 6897.241303456616, 6909.032735417046, 6499.0, 6510.08858759774, 6512.6092434454085, 6521.119648847345, 6531.281559028503, 3686.170611612419, 3725.5529336479253, 3725.683316918038, 3730.0603686083628, 3730.869419570302, 6890.483213758888, 7099.92900071003, 7121.0, 7133.643317834088, 7134.571925684476, 7011.263817299212, 7022.227554968949, 7022.964885175541, 7028.753993610199, 7034.859302813915, 7084.504084714021, 7099.3965512930945, 7104.7158113675905, 7108.68010939509, 7116.181639111362, 6900.689468973807, 6901.344372284625, 6908.3437073477935, 6913.308669133046, 6914.135733033371, 6594.604323740591, 6788.864222715617, 6799.5920244785475, 6861.108055952894, 6868.965655171693, 7028.0863487746265, 7107.466939979418, 7125.964370178116, 7126.679299431642, 7126.824074027727, 4827.08285425768, 4868.4157901050685, 4875.268709693574, 4884.023195361013, 4890.413150421972, 6839.350261725128, 6843.931560684329, 6849.315068493111, 6855.07456493367, 6861.4853885957755, 6540.313267107075, 6642.634655094016, 6673.933260667525, 6729.0579318894415, 6731.798046058626, 6620.0, 6680.098186744727, 6684.16447944007, 6686.866262674816, 6694.698738556874, 6528.249251336157, 6558.344165583403, 6571.277159512545, 6576.473882089325, 6579.703913324008, 6699.698513566804, 6735.4611631070375, 6747.325267473409, 6752.122224110834, 6755.392014718503, 6444.355564443706, 6561.442277406474, 6569.113169722217, 6589.143411356493, 6589.835254118494], "value": 5049.038530491309, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [805.9597020148991, 852.364988083878, 886.3479585709254, 886.9888327306869, 943.1370296178997, 15178.696426071485, 15500.689986200283, 15511.457099001536, 15512.61218469536, 15519.068855868656, 14684.632884177901, 14741.336639851206, 14756.926215368909, 14763.557093287218, 14768.556943291691, 728.0717085715702, 861.6553378648528, 881.7090360181157, 886.1227384888946, 888.6711916590871, 887.041994645781, 891.5586784541629, 893.0890491698464, 895.154079394972, 895.2793001633682, 938.779386844091, 939.2861425316775, 940.2571968145191, 941.0542404883083, 941.2752180820764, 756.2626439221742, 908.9091090890925, 913.0, 918.8300164469562, 920.6225447566466, 679.9490038247102, 680.0852852912824, 680.1124532485105, 682.2597481732327, 683.962382068986, 15287.388504459808, 15531.0, 15672.529824105295, 15673.686526269525, 15675.0, 15175.392984280616, 15222.314995825103, 15342.463013794575, 15379.077255364602, 15476.458323958608, 11902.226355286964, 12158.331291778948, 12168.81746773799, 12313.199642023239, 12490.0, 4117.670586353084, 4154.626083652455, 4169.520505141917, 4180.958190418088, 4224.134052519226, 52074.47925520734, 52230.21654675145, 52279.0, 52663.736681316346, 53134.468655313336, 10650.147988160928, 10685.57257709683, 10707.411092389993, 10750.462476876124, 10827.891721082846, 20436.795632043788, 20945.0, 21026.57946841085, 21035.68446473304, 21071.26250581222, 8997.685081022133, 9014.23379012778, 9015.0, 9075.909240907506, 9203.033681463483, 5161.561267292247, 5226.817061402832, 5248.685078895279, 5284.128118860345, 5336.17289320156, 3581.068922080278, 3670.0, 3673.577538583044, 3674.0998455378603, 3681.1901381695984, 666.1772710702279, 675.5001299038775, 684.5824047331124, 697.5744795674634, 732.6922692469176, 717.7794567940476, 817.1705718695529, 823.7899335669485, 833.0919297965247, 836.3184005035877, 9758.804823903482, 9771.951140244395, 9878.0, 9950.601975921027, 10058.145057670034, 685.1504134872722, 741.6514238307986, 745.7054463486892, 825.9834803303901, 859.6948083430292, 4643.2802915548145, 4715.669903106818, 4749.928751068736, 4781.760911954389, 4822.624411859934, 66063.33936660572, 66245.0, 66639.0, 66888.33111668918, 67247.66376168087, 57535.71232143813, 58824.0, 59080.0, 59241.70379148163, 59669.403305966385, 52574.47425525696, 54107.18839217415, 54357.45642543603, 54370.72814635901, 54849.45150548523, 9580.329376943548, 9647.469389183661, 9729.075737804897, 9751.658691945748, 9812.950935245279, 38153.61846381501, 38310.80844595759, 39184.21631567296, 40140.3978940322, 40769.0, 44238.0, 44493.55506445024, 47624.28563571619, 49751.25373119478, 50604.74697626488, 11520.251183673034, 11554.248973816675, 11667.066634669036, 11849.407529623311, 12024.819627705416, 12448.443944506937, 12651.430685619353, 12665.746685066431, 12931.482740690268, 13853.030287879752, 11066.170037247077, 13371.53199638008, 13400.329983500591, 13687.726245475234, 13806.447742090204, 12763.680907977376, 13041.282729449591, 13097.083204175617, 13229.40467678976, 13507.527236546674, 12852.036097292927, 12865.549705760253, 12881.742365152832, 12947.352632368533, 13270.601881943558, 11133.832992504957, 11232.943835280772, 11481.425928703698, 11669.533218671158, 11713.590024349107, 11475.713107172387, 11561.768764624492, 11804.17370784037, 11825.645230643095, 11965.222260553384], "value": 7203.954283111813, "unit": "score"}], "name": "dromaeo_css", "value": 7401.002877917553, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 113.0, 112.0, 111.0, 111.0, 109.0, 105.0, 110.0, 110.0, 109.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 132.0, 161.0, 173.0, 126.0, 161.0, 154.0, 129.0, 180.0, 136.0], "value": 150.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 161.0, 158.0, 160.0, 160.0, 159.0, 162.0, 160.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 77.0, 175.0, 73.0, 75.0, 77.0, 77.0, 155.0, 75.0], "value": 93.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 154.0, 92.0, 92.0, 92.0, 147.0, 92.0, 93.0, 160.0], "value": 110.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 146.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 96.0, 94.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 54.0, 53.0, 61.0, 54.0, 56.0, 77.0, 53.0, 53.0], "value": 57.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 60.0, 60.0, 60.0, 59.0, 59.0, 59.0, 59.0, 59.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 80.0, 73.0, 81.0, 73.0, 74.0, 81.0, 80.0, 73.0], "value": 75.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 116.0, 112.0, 115.0, 109.0, 111.0, 114.0, 114.0, 130.0, 127.0], "value": 116.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 159.0, 161.0, 160.0, 160.0, 157.0, 161.0, 162.0, 157.0], "value": 159.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 68.0, 67.0, 70.0, 68.0, 65.0, 67.0, 67.0, 64.0], "value": 67.4, "unit": "score"}], "name": "kraken", "value": 1519.2000000000003, "alertThreshold": 2.0}]} 08:34:31 INFO - Return code: 0 08:34:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:34:31 ERROR - # TBPL SUCCESS # 08:34:31 INFO - Running post-action listener: _resource_record_post_action 08:34:31 INFO - Running post-run listener: _resource_record_post_run 08:34:32 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 516042752; Read time: 0; Write time: 364904 08:34:32 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 264396800; Read time: 0; Write time: 224908 08:34:32 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 251645952; Read time: 0; Write time: 139996 08:34:32 INFO - Running post-run listener: _upload_blobber_files 08:34:32 INFO - Blob upload gear active. 08:34:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:34:32 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 08:34:32 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:34:32 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:34:33 INFO - (blobuploader) - INFO - Open directory for files ... 08:34:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:34:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:34:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:34:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:34:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:34:34 INFO - (blobuploader) - INFO - Done attempting. 08:34:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:34:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:34:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:34:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:34:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:34:35 INFO - (blobuploader) - INFO - Done attempting. 08:34:35 INFO - (blobuploader) - INFO - Iteration through files over. 08:34:35 INFO - Return code: 0 08:34:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:34:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:34:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ed52b63a0c2dc3d6ce0cadc92c586c6419d5157ca0d5e3b206d457bcaf79989b7350651812be3f0e83f126577b36777cae3333ac0e07d3a03f0b68bc0e8e7521", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/59e109d1ff930993135ca23c122f9eee2677a9628388e282a5e147f5b03737d2fed66ab3770f6eec298cfa26e1548a49900863c1b3c18b204240b93b03c203b7"} 08:34:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:34:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:34:35 INFO - Contents: 08:34:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ed52b63a0c2dc3d6ce0cadc92c586c6419d5157ca0d5e3b206d457bcaf79989b7350651812be3f0e83f126577b36777cae3333ac0e07d3a03f0b68bc0e8e7521", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/59e109d1ff930993135ca23c122f9eee2677a9628388e282a5e147f5b03737d2fed66ab3770f6eec298cfa26e1548a49900863c1b3c18b204240b93b03c203b7"} 08:34:35 INFO - Running post-run listener: copy_logs_to_upload_dir 08:34:35 INFO - Copying logs to upload dir... 08:34:35 INFO - mkdir: /builds/slave/test/build/upload/logs 08:34:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1225.552637 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 25 secs) (at 2016-05-30 08:34:35.250958) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 08:34:35.255154) ========= 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=6dbc10da6d83fee962c624be000001a8-1464621247.789565-1446120904 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-Aurora/sha512/ed52b63a0c2dc3d6ce0cadc92c586c6419d5157ca0d5e3b206d457bcaf79989b7350651812be3f0e83f126577b36777cae3333ac0e07d3a03f0b68bc0e8e7521", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/59e109d1ff930993135ca23c122f9eee2677a9628388e282a5e147f5b03737d2fed66ab3770f6eec298cfa26e1548a49900863c1b3c18b204240b93b03c203b7"} build_url:https://queue.taskcluster.net/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011360 build_url: 'https://queue.taskcluster.net/v1/task/fbM64-YYRj60ndUG5ctAXA/artifacts/public/build/firefox-48.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ed52b63a0c2dc3d6ce0cadc92c586c6419d5157ca0d5e3b206d457bcaf79989b7350651812be3f0e83f126577b36777cae3333ac0e07d3a03f0b68bc0e8e7521", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/59e109d1ff930993135ca23c122f9eee2677a9628388e282a5e147f5b03737d2fed66ab3770f6eec298cfa26e1548a49900863c1b3c18b204240b93b03c203b7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-30 08:34:35.282214) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 08:34:35.282615) ========= 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=6dbc10da6d83fee962c624be000001a8-1464621247.789565-1446120904 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004414 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-30 08:34:35.365555) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 08:34:35.366050) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-30 08:34:35.366346) ========= ========= Total master_lag: 0.16 =========