builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-014 starttime: 1461056756.3 results: success (0) buildid: 20160418233037 builduid: 98ae23c253cf42e7abf51d86f4c29b89 revision: 9a8ff2f4978493c3fd9982652a09ffcdf2333a75 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 02:05:56.295686) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 02:05:56.296259) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 02:05:56.296627) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 02:05:56.313263) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 02:05:56.313549) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1461055996.254335-530092315 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-19 02:05:56-- 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% 222M=0s 2016-04-19 02:05:56 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102295 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 02:05:56.428680) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 02:05:56.428967) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1461055996.254335-530092315 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017747 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 02:05:56.478942) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 02:05:56.479470) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9a8ff2f4978493c3fd9982652a09ffcdf2333a75 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 9a8ff2f4978493c3fd9982652a09ffcdf2333a75 --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=fa9c93d544b966bd2b8d485a000001c6-1461055996.254335-530092315 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-19 02:05:57,093 truncating revision to first 12 chars 2016-04-19 02:05:57,093 Setting DEBUG logging. 2016-04-19 02:05:57,093 attempt 1/10 2016-04-19 02:05:57,093 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9a8ff2f49784?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-19 02:05:57,358 unpacking tar archive at: fx-team-9a8ff2f49784/testing/mozharness/ program finished with exit code 0 elapsedTime=0.579803 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 02:05:57.075399) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 02:05:57.075974) ========= script_repo_revision: 9a8ff2f4978493c3fd9982652a09ffcdf2333a75 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 02:05:57.076917) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 02:05:57.077594) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 02:05:57.092180) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-04-19 02:05:57.092446) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=fa9c93d544b966bd2b8d485a000001c6-1461055996.254335-530092315 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:05:57 INFO - MultiFileLogger online at 20160419 02:05:57 in /builds/slave/test 02:05:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 02:05:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:05:57 INFO - {'append_to_log': False, 02:05:57 INFO - 'base_work_dir': '/builds/slave/test', 02:05:57 INFO - 'blob_upload_branch': 'Fx-Team', 02:05:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:05:57 INFO - 'branch': 'Fx-Team', 02:05:57 INFO - 'buildbot_json_path': 'buildprops.json', 02:05:57 INFO - 'config_files': ('talos/linux_config.py',), 02:05:57 INFO - 'default_actions': ('clobber', 02:05:57 INFO - 'read-buildbot-config', 02:05:57 INFO - 'download-and-extract', 02:05:57 INFO - 'populate-webroot', 02:05:57 INFO - 'create-virtualenv', 02:05:57 INFO - 'install', 02:05:57 INFO - 'run-tests'), 02:05:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:05:57 INFO - 'download_minidump_stackwalk': True, 02:05:57 INFO - 'download_symbols': 'ondemand', 02:05:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:05:57 INFO - 'tooltool.py': '/tools/tooltool.py', 02:05:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:05:57 INFO - '/tools/misc-python/virtualenv.py')}, 02:05:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:05:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:05:57 INFO - 'installer_path': 'installer.exe', 02:05:57 INFO - 'log_level': 'info', 02:05:57 INFO - 'log_name': 'talos', 02:05:57 INFO - 'log_to_console': True, 02:05:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:05:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:05:57 INFO - 'opt_config_files': (), 02:05:57 INFO - 'pip_index': False, 02:05:57 INFO - 'sps_profile': False, 02:05:57 INFO - 'sps_profile_interval': 0, 02:05:57 INFO - 'suite': 'dromaeojs', 02:05:57 INFO - 'system_bits': '32', 02:05:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:05:57 INFO - 'title': 'talos-linux64-ix-014', 02:05:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:05:57 INFO - 'use_talos_json': True, 02:05:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:05:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:05:57 INFO - 'work_dir': 'build'} 02:05:57 INFO - ##### 02:05:57 INFO - ##### Running clobber step. 02:05:57 INFO - ##### 02:05:57 INFO - Running pre-action listener: _resource_record_pre_action 02:05:57 INFO - Running main action method: clobber 02:05:57 INFO - rmtree: /builds/slave/test/build 02:05:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:05:58 INFO - Running post-action listener: _resource_record_post_action 02:05:58 INFO - ##### 02:05:58 INFO - ##### Running read-buildbot-config step. 02:05:58 INFO - ##### 02:05:58 INFO - Running pre-action listener: _resource_record_pre_action 02:05:58 INFO - Running main action method: read_buildbot_config 02:05:58 INFO - Using buildbot properties: 02:05:58 INFO - { 02:05:58 INFO - "project": "", 02:05:58 INFO - "product": "firefox", 02:05:58 INFO - "script_repo_revision": "production", 02:05:58 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:05:58 INFO - "repository": "", 02:05:58 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 02:05:58 INFO - "buildid": "20160418233037", 02:05:58 INFO - "pgo_build": "True", 02:05:58 INFO - "basedir": "/builds/slave/test", 02:05:58 INFO - "buildnumber": 43, 02:05:58 INFO - "slavename": "talos-linux64-ix-014", 02:05:58 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:05:58 INFO - "platform": "ubuntu64_hw", 02:05:58 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:05:58 INFO - "branch": "fx-team", 02:05:58 INFO - "repo_path": "integration/fx-team", 02:05:58 INFO - "revision": "9a8ff2f4978493c3fd9982652a09ffcdf2333a75", 02:05:58 INFO - "stage_platform": "linux64-pgo", 02:05:58 INFO - "builduid": "98ae23c253cf42e7abf51d86f4c29b89", 02:05:58 INFO - "slavebuilddir": "test" 02:05:58 INFO - } 02:05:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/HNgas2hnQxasLDv-WckIjw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 02:05:58 INFO - Running post-action listener: _resource_record_post_action 02:05:58 INFO - ##### 02:05:58 INFO - ##### Running download-and-extract step. 02:05:58 INFO - ##### 02:05:58 INFO - Running pre-action listener: _resource_record_pre_action 02:05:58 INFO - Running main action method: download_and_extract 02:05:58 INFO - mkdir: /builds/slave/test/build/tests 02:05:58 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')]} 02:05:58 INFO - https://queue.taskcluster.net/v1/task/HNgas2hnQxasLDv-WckIjw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:05:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNgas2hnQxasLDv-WckIjw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:05:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNgas2hnQxasLDv-WckIjw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:05:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNgas2hnQxasLDv-WckIjw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:05:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNgas2hnQxasLDv-WckIjw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:06:10 INFO - Downloaded 1361 bytes. 02:06:10 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:06:10 INFO - Using the following test package requirements: 02:06:10 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 02:06:10 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:06:10 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:06:10 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:06:10 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:06:10 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:06:10 INFO - u'jsshell-linux-x86_64.zip'], 02:06:10 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:06:10 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:06:10 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 02:06:10 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:06:10 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:06:10 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:06:10 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:06:10 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:06:10 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:06:10 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:06:10 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:06:10 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:06: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')]} 02:06:10 INFO - https://queue.taskcluster.net/v1/task/HNgas2hnQxasLDv-WckIjw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:06:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNgas2hnQxasLDv-WckIjw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:06:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNgas2hnQxasLDv-WckIjw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:06:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNgas2hnQxasLDv-WckIjw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:06:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNgas2hnQxasLDv-WckIjw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:06:17 INFO - Downloaded 23780832 bytes. 02:06:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:06:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:06:18 INFO - Return code: 0 02:06:18 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:06:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:06:18 INFO - https://queue.taskcluster.net/v1/task/HNgas2hnQxasLDv-WckIjw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:06:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNgas2hnQxasLDv-WckIjw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:06:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNgas2hnQxasLDv-WckIjw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:06:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNgas2hnQxasLDv-WckIjw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:06:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNgas2hnQxasLDv-WckIjw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:06:19 INFO - Downloaded 23780832 bytes. 02:06:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:06:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:06:21 INFO - Return code: 0 02:06:21 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')]} 02:06:21 INFO - https://queue.taskcluster.net/v1/task/HNgas2hnQxasLDv-WckIjw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:06:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNgas2hnQxasLDv-WckIjw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 02:06:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNgas2hnQxasLDv-WckIjw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 02:06:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNgas2hnQxasLDv-WckIjw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 02:06:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNgas2hnQxasLDv-WckIjw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:06:22 INFO - Downloaded 10845952 bytes. 02:06:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:06:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:06:22 INFO - Return code: 0 02:06: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')]} 02:06:22 INFO - https://queue.taskcluster.net/v1/task/HNgas2hnQxasLDv-WckIjw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:06:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNgas2hnQxasLDv-WckIjw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:06:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNgas2hnQxasLDv-WckIjw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:06:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNgas2hnQxasLDv-WckIjw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:06:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HNgas2hnQxasLDv-WckIjw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:06:24 INFO - Downloaded 58241713 bytes. 02:06:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HNgas2hnQxasLDv-WckIjw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:06:24 INFO - mkdir: /builds/slave/test/properties 02:06:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:06:24 INFO - Writing to file /builds/slave/test/properties/build_url 02:06:24 INFO - Contents: 02:06:24 INFO - build_url:https://queue.taskcluster.net/v1/task/HNgas2hnQxasLDv-WckIjw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:06:25 INFO - Running post-action listener: _resource_record_post_action 02:06:25 INFO - Running post-action listener: set_extra_try_arguments 02:06:25 INFO - ##### 02:06:25 INFO - ##### Running populate-webroot step. 02:06:25 INFO - ##### 02:06:25 INFO - Running pre-action listener: _resource_record_pre_action 02:06:25 INFO - Running main action method: populate_webroot 02:06:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:06:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:06:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:06:25 INFO - '--tppagecycles', 02:06:25 INFO - '7'], 02:06:25 INFO - 'tests': ['tsvgm']}}, 02:06:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:06:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:06:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:06:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:06:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:06:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:06:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:06:25 INFO - 'talos_options': ['--disable-e10s'], 02:06:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:06:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:06:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:06:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:06:25 INFO - 'talos_options': ['--disable-e10s'], 02:06:25 INFO - 'tests': ['damp', 'tps']}, 02:06:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:06:25 INFO - 'tests': ['damp', 'tps']}, 02:06:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:06:25 INFO - 'tests': ['dromaeo_dom']}, 02:06:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:06:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:06:25 INFO - 'tests': ['a11yr', 02:06:25 INFO - 'ts_paint', 02:06:25 INFO - 'tpaint', 02:06:25 INFO - 'sessionrestore', 02:06:25 INFO - 'sessionrestore_no_auto_restore', 02:06:25 INFO - 'tabpaint']}, 02:06:25 INFO - 'other-e10s': {'tests': ['a11yr', 02:06:25 INFO - 'ts_paint', 02:06:25 INFO - 'tpaint', 02:06:25 INFO - 'sessionrestore', 02:06:25 INFO - 'sessionrestore_no_auto_restore', 02:06:25 INFO - 'tabpaint']}, 02:06:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:06:25 INFO - 'ts_paint', 02:06:25 INFO - 'tpaint', 02:06:25 INFO - 'sessionrestore', 02:06:25 INFO - 'sessionrestore_no_auto_restore', 02:06:25 INFO - 'tabpaint']}, 02:06:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:06:25 INFO - 'ts_paint', 02:06:25 INFO - 'tpaint', 02:06:25 INFO - 'sessionrestore', 02:06:25 INFO - 'sessionrestore_no_auto_restore', 02:06:25 INFO - 'tabpaint']}, 02:06:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:06:25 INFO - 'tests': ['a11yr', 02:06:25 INFO - 'ts_paint', 02:06:25 INFO - 'tpaint', 02:06:25 INFO - 'sessionrestore', 02:06:25 INFO - 'sessionrestore_no_auto_restore', 02:06:25 INFO - 'tabpaint']}, 02:06:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:06:25 INFO - 'tests': ['a11yr', 02:06:25 INFO - 'ts_paint', 02:06:25 INFO - 'tpaint', 02:06:25 INFO - 'sessionrestore', 02:06:25 INFO - 'sessionrestore_no_auto_restore', 02:06:25 INFO - 'tabpaint']}, 02:06:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:06:25 INFO - 'tests': ['tsvgx', 02:06:25 INFO - 'tsvgr_opacity', 02:06:25 INFO - 'tart', 02:06:25 INFO - 'tscrollx', 02:06:25 INFO - 'cart']}, 02:06:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:06:25 INFO - 'tsvgr_opacity', 02:06:25 INFO - 'tart', 02:06:25 INFO - 'tscrollx', 02:06:25 INFO - 'cart']}, 02:06:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:06:25 INFO - 'talos_options': ['--disable-e10s'], 02:06:25 INFO - 'tests': ['tp5o']}, 02:06:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:06:25 INFO - 'tests': ['tp5o']}, 02:06:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:06:25 INFO - 'talos_options': ['--disable-e10s', 02:06:25 INFO - '--xperf_path', 02:06:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:06:25 INFO - 'tests': ['tp5n']}, 02:06:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:06:25 INFO - 'talos_options': ['--xperf_path', 02:06:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:06:25 INFO - 'tests': ['tp5n']}}, 02:06:25 INFO - 'talos.zip': {'path': '', 02:06:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:06:25 INFO - Running post-action listener: _resource_record_post_action 02:06:25 INFO - ##### 02:06:25 INFO - ##### Running create-virtualenv step. 02:06:25 INFO - ##### 02:06:25 INFO - Running pre-action listener: _resource_record_pre_action 02:06:25 INFO - Running main action method: create_virtualenv 02:06:25 INFO - Creating virtualenv /builds/slave/test/build/venv 02:06:25 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 02:06:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:06:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:06:25 INFO - Using real prefix '/usr' 02:06:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:06:26 INFO - Installing distribute.............................................................................................................................................................................................done. 02:06:28 INFO - Installing pip.................done. 02:06:28 INFO - Return code: 0 02:06:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:06:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:06:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4d15c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a19a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1430810>, '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 0x1431710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1431ba0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461055996.254335-530092315', '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 02:06:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:06:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:06:28 INFO - Using env: {'DISPLAY': ':0', 02:06:28 INFO - 'HOME': '/home/cltbld', 02:06:28 INFO - 'LANG': 'en_US.UTF-8', 02:06:28 INFO - 'LANGUAGE': 'en_US:en', 02:06:28 INFO - 'LOGNAME': 'cltbld', 02:06:28 INFO - 'MAIL': '/var/mail/cltbld', 02:06:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:28 INFO - 'MOZ_NO_REMOTE': '1', 02:06:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:28 INFO - 'NO_EM_RESTART': '1', 02:06:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:28 INFO - 'PWD': '/builds/slave/test', 02:06:28 INFO - 'SHELL': '/bin/bash', 02:06:28 INFO - 'SHLVL': '1', 02:06:28 INFO - 'TERM': 'linux', 02:06:28 INFO - 'TMOUT': '86400', 02:06:28 INFO - 'USER': 'cltbld', 02:06:28 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461055996.254335-530092315', 02:06:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:28 INFO - '_': '/tools/buildbot/bin/python'} 02:06:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:28 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 02:06:28 INFO - Cleaning up... 02:06:28 INFO - Return code: 0 02:06:28 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:06:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:06:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe4d15c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a19a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1430810>, '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 0x1431710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1431ba0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461055996.254335-530092315', '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 02:06:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 02:06:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:06:28 INFO - Using env: {'DISPLAY': ':0', 02:06:28 INFO - 'HOME': '/home/cltbld', 02:06:28 INFO - 'LANG': 'en_US.UTF-8', 02:06:28 INFO - 'LANGUAGE': 'en_US:en', 02:06:28 INFO - 'LOGNAME': 'cltbld', 02:06:28 INFO - 'MAIL': '/var/mail/cltbld', 02:06:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:28 INFO - 'MOZ_NO_REMOTE': '1', 02:06:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:28 INFO - 'NO_EM_RESTART': '1', 02:06:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:28 INFO - 'PWD': '/builds/slave/test', 02:06:28 INFO - 'SHELL': '/bin/bash', 02:06:28 INFO - 'SHLVL': '1', 02:06:28 INFO - 'TERM': 'linux', 02:06:28 INFO - 'TMOUT': '86400', 02:06:28 INFO - 'USER': 'cltbld', 02:06:28 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461055996.254335-530092315', 02:06:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:28 INFO - '_': '/tools/buildbot/bin/python'} 02:06:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:28 INFO - Downloading/unpacking psutil>=0.7.1 02:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:06:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:06:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:06:30 INFO - Installing collected packages: psutil 02:06:30 INFO - Running setup.py install for psutil 02:06:30 INFO - building 'psutil._psutil_linux' extension 02:06:30 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 02:06:30 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 02:06:30 INFO - building 'psutil._psutil_posix' extension 02:06:30 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 02:06:31 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 02:06:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:06:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:06:31 INFO - Successfully installed psutil 02:06:31 INFO - Cleaning up... 02:06:31 INFO - Return code: 0 02:06:31 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:06: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')]} 02:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06: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')]} 02:06:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:31 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 0x7fe4d15c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a19a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1430810>, '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 0x1431710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1431ba0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461055996.254335-530092315', '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 02:06:31 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 02:06:31 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 02:06:31 INFO - Using env: {'DISPLAY': ':0', 02:06:31 INFO - 'HOME': '/home/cltbld', 02:06:31 INFO - 'LANG': 'en_US.UTF-8', 02:06:31 INFO - 'LANGUAGE': 'en_US:en', 02:06:31 INFO - 'LOGNAME': 'cltbld', 02:06:31 INFO - 'MAIL': '/var/mail/cltbld', 02:06:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:31 INFO - 'MOZ_NO_REMOTE': '1', 02:06:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:31 INFO - 'NO_EM_RESTART': '1', 02:06:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:31 INFO - 'PWD': '/builds/slave/test', 02:06:31 INFO - 'SHELL': '/bin/bash', 02:06:31 INFO - 'SHLVL': '1', 02:06:31 INFO - 'TERM': 'linux', 02:06:31 INFO - 'TMOUT': '86400', 02:06:31 INFO - 'USER': 'cltbld', 02:06:31 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461055996.254335-530092315', 02:06:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:31 INFO - '_': '/tools/buildbot/bin/python'} 02:06:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:31 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:33 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:06:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:06:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:06:33 INFO - Installing collected packages: mozsystemmonitor 02:06:33 INFO - Running setup.py install for mozsystemmonitor 02:06:33 INFO - Successfully installed mozsystemmonitor 02:06:33 INFO - Cleaning up... 02:06:33 INFO - Return code: 0 02:06:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:06:33 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')]} 02:06:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:33 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')]} 02:06:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:33 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 0x7fe4d15c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a19a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1430810>, '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 0x1431710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1431ba0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461055996.254335-530092315', '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 02:06:33 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 02:06:33 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 02:06:33 INFO - Using env: {'DISPLAY': ':0', 02:06:33 INFO - 'HOME': '/home/cltbld', 02:06:33 INFO - 'LANG': 'en_US.UTF-8', 02:06:33 INFO - 'LANGUAGE': 'en_US:en', 02:06:33 INFO - 'LOGNAME': 'cltbld', 02:06:33 INFO - 'MAIL': '/var/mail/cltbld', 02:06:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:33 INFO - 'MOZ_NO_REMOTE': '1', 02:06:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:33 INFO - 'NO_EM_RESTART': '1', 02:06:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:33 INFO - 'PWD': '/builds/slave/test', 02:06:33 INFO - 'SHELL': '/bin/bash', 02:06:33 INFO - 'SHLVL': '1', 02:06:33 INFO - 'TERM': 'linux', 02:06:33 INFO - 'TMOUT': '86400', 02:06:33 INFO - 'USER': 'cltbld', 02:06:33 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461055996.254335-530092315', 02:06:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:33 INFO - '_': '/tools/buildbot/bin/python'} 02:06:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:33 INFO - Downloading/unpacking blobuploader==1.2.4 02:06:33 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 02:06:33 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 02:06:33 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 02:06:33 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 02:06:33 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 02:06:33 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 02:06:35 INFO - Downloading blobuploader-1.2.4.tar.gz 02:06:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:06:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:06: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 02:06: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 02:06: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 02:06: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 02:06: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 02:06: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 02:06:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:06:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:06:36 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 02:06:36 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 02:06:36 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 02:06:36 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 02:06:36 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 02:06:36 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 02:06:36 INFO - Downloading docopt-0.6.1.tar.gz 02:06:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:06:36 INFO - Installing collected packages: blobuploader, requests, docopt 02:06:36 INFO - Running setup.py install for blobuploader 02:06:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:06:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:06:36 INFO - Running setup.py install for requests 02:06:36 INFO - Running setup.py install for docopt 02:06:36 INFO - Successfully installed blobuploader requests docopt 02:06:36 INFO - Cleaning up... 02:06:37 INFO - Return code: 0 02:06:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:06:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:06:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:06:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:37 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 0x7fe4d15c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a19a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1430810>, '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 0x1431710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1431ba0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461055996.254335-530092315', '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 02:06:37 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 02:06:37 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 02:06:37 INFO - Using env: {'DISPLAY': ':0', 02:06:37 INFO - 'HOME': '/home/cltbld', 02:06:37 INFO - 'LANG': 'en_US.UTF-8', 02:06:37 INFO - 'LANGUAGE': 'en_US:en', 02:06:37 INFO - 'LOGNAME': 'cltbld', 02:06:37 INFO - 'MAIL': '/var/mail/cltbld', 02:06:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:37 INFO - 'MOZ_NO_REMOTE': '1', 02:06:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:37 INFO - 'NO_EM_RESTART': '1', 02:06:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:37 INFO - 'PWD': '/builds/slave/test', 02:06:37 INFO - 'SHELL': '/bin/bash', 02:06:37 INFO - 'SHLVL': '1', 02:06:37 INFO - 'TERM': 'linux', 02:06:37 INFO - 'TMOUT': '86400', 02:06:37 INFO - 'USER': 'cltbld', 02:06:37 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461055996.254335-530092315', 02:06:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:37 INFO - '_': '/tools/buildbot/bin/python'} 02:06:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:06:37 INFO - Running setup.py (path:/tmp/pip-yYkZlq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:06:37 INFO - Running setup.py (path:/tmp/pip-VzGqvd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:06:37 INFO - Running setup.py (path:/tmp/pip-8UvqIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:06:37 INFO - Running setup.py (path:/tmp/pip-L28GIg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:06:37 INFO - Running setup.py (path:/tmp/pip-ss8_Ew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:06:37 INFO - Running setup.py (path:/tmp/pip-AY3d8X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:06:37 INFO - Running setup.py (path:/tmp/pip-CWQfLe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:06:37 INFO - Running setup.py (path:/tmp/pip-BVR5PT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:06:37 INFO - Running setup.py (path:/tmp/pip-3fJKRq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:06:37 INFO - Running setup.py (path:/tmp/pip-fF4YVa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:06:37 INFO - Running setup.py (path:/tmp/pip-4nMXWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:06:38 INFO - Running setup.py (path:/tmp/pip-MN0oSh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:06:38 INFO - Running setup.py (path:/tmp/pip-hGx77M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:06:38 INFO - Running setup.py (path:/tmp/pip-QUCx6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:06:38 INFO - Running setup.py (path:/tmp/pip-zhdqs1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:06:38 INFO - Running setup.py (path:/tmp/pip-DqaAtb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:06:38 INFO - Running setup.py (path:/tmp/pip-SyJdbT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:06:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:06:38 INFO - Running setup.py install for manifestparser 02:06:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:06:38 INFO - Running setup.py install for mozcrash 02:06:38 INFO - Running setup.py install for mozdebug 02:06:38 INFO - Running setup.py install for mozdevice 02:06:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:06:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:06:38 INFO - Running setup.py install for mozfile 02:06:38 INFO - Running setup.py install for mozhttpd 02:06:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:06:39 INFO - Running setup.py install for mozinfo 02:06:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:06:39 INFO - Running setup.py install for mozInstall 02:06:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:06:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:06:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:06:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:06:39 INFO - Running setup.py install for mozleak 02:06:39 INFO - Running setup.py install for mozlog 02:06:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:06:39 INFO - Running setup.py install for moznetwork 02:06:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:06:39 INFO - Running setup.py install for mozprocess 02:06:39 INFO - Running setup.py install for mozprofile 02:06:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:06:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:06:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:06:39 INFO - Running setup.py install for mozrunner 02:06:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:06:39 INFO - Running setup.py install for mozscreenshot 02:06:40 INFO - Running setup.py install for moztest 02:06:40 INFO - Running setup.py install for mozversion 02:06:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:06:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:06:40 INFO - Cleaning up... 02:06:40 INFO - Return code: 0 02:06:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:06: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')]} 02:06:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06: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')]} 02:06:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:40 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 0x7fe4d15c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a19a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1430810>, '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 0x1431710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1431ba0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461055996.254335-530092315', '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 02:06:40 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 02:06:40 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 02:06:40 INFO - Using env: {'DISPLAY': ':0', 02:06:40 INFO - 'HOME': '/home/cltbld', 02:06:40 INFO - 'LANG': 'en_US.UTF-8', 02:06:40 INFO - 'LANGUAGE': 'en_US:en', 02:06:40 INFO - 'LOGNAME': 'cltbld', 02:06:40 INFO - 'MAIL': '/var/mail/cltbld', 02:06:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:40 INFO - 'MOZ_NO_REMOTE': '1', 02:06:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:40 INFO - 'NO_EM_RESTART': '1', 02:06:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:40 INFO - 'PWD': '/builds/slave/test', 02:06:40 INFO - 'SHELL': '/bin/bash', 02:06:40 INFO - 'SHLVL': '1', 02:06:40 INFO - 'TERM': 'linux', 02:06:40 INFO - 'TMOUT': '86400', 02:06:40 INFO - 'USER': 'cltbld', 02:06:40 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461055996.254335-530092315', 02:06:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:40 INFO - '_': '/tools/buildbot/bin/python'} 02:06:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:06:40 INFO - Running setup.py (path:/tmp/pip-nM_wEH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:06:40 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)) 02:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:06:40 INFO - Running setup.py (path:/tmp/pip-6gUHzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:06:40 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)) 02:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:06:40 INFO - Running setup.py (path:/tmp/pip-aUEa4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:06:40 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)) 02:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:06:40 INFO - Running setup.py (path:/tmp/pip-nuyWzc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:06:40 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)) 02:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:06:40 INFO - Running setup.py (path:/tmp/pip-YNHaJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:06:40 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)) 02:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:06:40 INFO - Running setup.py (path:/tmp/pip-XzYlPs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:06:40 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)) 02:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:06:40 INFO - Running setup.py (path:/tmp/pip-IPMUsk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:06:40 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)) 02:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:06:40 INFO - Running setup.py (path:/tmp/pip-RKWiwT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:06:41 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)) 02:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:06:41 INFO - Running setup.py (path:/tmp/pip-Okx0rB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:06:41 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)) 02:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:06:41 INFO - Running setup.py (path:/tmp/pip-890Wig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:06:41 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)) 02:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:06:41 INFO - Running setup.py (path:/tmp/pip-5EVkZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:06:41 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)) 02:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:06:41 INFO - Running setup.py (path:/tmp/pip-K9VlEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:06:41 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)) 02:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:06:41 INFO - Running setup.py (path:/tmp/pip-R65w1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:06:41 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)) 02:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:06:41 INFO - Running setup.py (path:/tmp/pip-T6uI3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:06:41 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)) 02:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:06:41 INFO - Running setup.py (path:/tmp/pip-eZTG2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:06:41 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)) 02:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:06:41 INFO - Running setup.py (path:/tmp/pip-pdeEh1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:06:41 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)) 02:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:06:41 INFO - Running setup.py (path:/tmp/pip-NGvE35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:06:41 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)) 02:06:41 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)) 02:06:41 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)) 02:06:41 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)) 02:06:41 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)) 02:06:41 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)) 02:06:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:06: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 02:06: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 02:06: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 02:06: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 02:06: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 02:06: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 02:06:43 INFO - Downloading blessings-1.6.tar.gz 02:06:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:06:43 INFO - Installing collected packages: blessings 02:06:43 INFO - Running setup.py install for blessings 02:06:43 INFO - Successfully installed blessings 02:06:43 INFO - Cleaning up... 02:06:43 INFO - Return code: 0 02:06:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:06:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:06:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:06:44 INFO - Reading from file tmpfile_stdout 02:06:44 INFO - Current package versions: 02:06:44 INFO - argparse == 1.2.1 02:06:44 INFO - blessings == 1.6 02:06:44 INFO - blobuploader == 1.2.4 02:06:44 INFO - docopt == 0.6.1 02:06:44 INFO - manifestparser == 1.1 02:06:44 INFO - mozInstall == 1.12 02:06:44 INFO - mozcrash == 0.17 02:06:44 INFO - mozdebug == 0.1 02:06:44 INFO - mozdevice == 0.48 02:06:44 INFO - mozfile == 1.2 02:06:44 INFO - mozhttpd == 0.7 02:06:44 INFO - mozinfo == 0.9 02:06:44 INFO - mozleak == 0.1 02:06:44 INFO - mozlog == 3.1 02:06:44 INFO - moznetwork == 0.27 02:06:44 INFO - mozprocess == 0.22 02:06:44 INFO - mozprofile == 0.28 02:06:44 INFO - mozrunner == 6.11 02:06:44 INFO - mozscreenshot == 0.1 02:06:44 INFO - mozsystemmonitor == 0.0 02:06:44 INFO - moztest == 0.7 02:06:44 INFO - mozversion == 1.4 02:06:44 INFO - psutil == 3.1.1 02:06:44 INFO - requests == 1.2.3 02:06:44 INFO - wsgiref == 0.1.2 02:06:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:06:44 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')]} 02:06:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:44 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')]} 02:06:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:44 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 0x7fe4d15c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a19a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1430810>, '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 0x1431710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1431ba0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461055996.254335-530092315', '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 02:06:44 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 02:06:44 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 02:06:44 INFO - Using env: {'DISPLAY': ':0', 02:06:44 INFO - 'HOME': '/home/cltbld', 02:06:44 INFO - 'LANG': 'en_US.UTF-8', 02:06:44 INFO - 'LANGUAGE': 'en_US:en', 02:06:44 INFO - 'LOGNAME': 'cltbld', 02:06:44 INFO - 'MAIL': '/var/mail/cltbld', 02:06:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:44 INFO - 'MOZ_NO_REMOTE': '1', 02:06:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:44 INFO - 'NO_EM_RESTART': '1', 02:06:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:44 INFO - 'PWD': '/builds/slave/test', 02:06:44 INFO - 'SHELL': '/bin/bash', 02:06:44 INFO - 'SHLVL': '1', 02:06:44 INFO - 'TERM': 'linux', 02:06:44 INFO - 'TMOUT': '86400', 02:06:44 INFO - 'USER': 'cltbld', 02:06:44 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461055996.254335-530092315', 02:06:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:44 INFO - '_': '/tools/buildbot/bin/python'} 02:06:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:44 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)) 02:06:44 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)) 02:06:44 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)) 02:06:44 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)) 02:06:44 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)) 02:06:44 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)) 02:06:44 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)) 02:06:44 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)) 02:06:44 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)) 02:06:44 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)) 02:06:44 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)) 02:06:44 INFO - Cleaning up... 02:06:44 INFO - Return code: 0 02:06:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:06:44 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')]} 02:06:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:44 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')]} 02:06:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:44 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 0x7fe4d15c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a19a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1430810>, '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 0x1431710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1431ba0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461055996.254335-530092315', '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 02:06:44 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 02:06:44 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 02:06:44 INFO - Using env: {'DISPLAY': ':0', 02:06:44 INFO - 'HOME': '/home/cltbld', 02:06:44 INFO - 'LANG': 'en_US.UTF-8', 02:06:44 INFO - 'LANGUAGE': 'en_US:en', 02:06:44 INFO - 'LOGNAME': 'cltbld', 02:06:44 INFO - 'MAIL': '/var/mail/cltbld', 02:06:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:44 INFO - 'MOZ_NO_REMOTE': '1', 02:06:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:44 INFO - 'NO_EM_RESTART': '1', 02:06:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:44 INFO - 'PWD': '/builds/slave/test', 02:06:44 INFO - 'SHELL': '/bin/bash', 02:06:44 INFO - 'SHLVL': '1', 02:06:44 INFO - 'TERM': 'linux', 02:06:44 INFO - 'TMOUT': '86400', 02:06:44 INFO - 'USER': 'cltbld', 02:06:44 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461055996.254335-530092315', 02:06:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:44 INFO - '_': '/tools/buildbot/bin/python'} 02:06:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:44 INFO - Downloading/unpacking jsonschema 02:06:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:06:46 INFO - Downloading/unpacking functools32 (from jsonschema) 02:06:46 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 02:06:46 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 02:06:46 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 02:06:46 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 02:06:46 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 02:06:46 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 02:06:46 INFO - Downloading functools32-3.2.3-2.tar.gz 02:06:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:06:46 INFO - warning: no files found matching '*.txt' 02:06:46 INFO - no previously-included directories found matching 'build' 02:06:46 INFO - no previously-included directories found matching 'dist' 02:06:46 INFO - no previously-included directories found matching '.git*' 02:06:46 INFO - Installing collected packages: jsonschema, functools32 02:06:46 INFO - Running setup.py install for functools32 02:06:46 INFO - warning: no files found matching '*.txt' 02:06:46 INFO - no previously-included directories found matching 'build' 02:06:46 INFO - no previously-included directories found matching 'dist' 02:06:46 INFO - no previously-included directories found matching '.git*' 02:06:46 INFO - Successfully installed jsonschema functools32 02:06:46 INFO - Cleaning up... 02:06:46 INFO - Return code: 0 02:06:46 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:06:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:06:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:06:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:46 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 0x7fe4d15c6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a19a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1430810>, '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 0x1431710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1431ba0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461055996.254335-530092315', '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 02:06:46 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 02:06:46 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 02:06:46 INFO - Using env: {'DISPLAY': ':0', 02:06:46 INFO - 'HOME': '/home/cltbld', 02:06:46 INFO - 'LANG': 'en_US.UTF-8', 02:06:46 INFO - 'LANGUAGE': 'en_US:en', 02:06:46 INFO - 'LOGNAME': 'cltbld', 02:06:46 INFO - 'MAIL': '/var/mail/cltbld', 02:06:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:46 INFO - 'MOZ_NO_REMOTE': '1', 02:06:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:06:46 INFO - 'NO_EM_RESTART': '1', 02:06:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:06:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:46 INFO - 'PWD': '/builds/slave/test', 02:06:46 INFO - 'SHELL': '/bin/bash', 02:06:46 INFO - 'SHLVL': '1', 02:06:46 INFO - 'TERM': 'linux', 02:06:46 INFO - 'TMOUT': '86400', 02:06:46 INFO - 'USER': 'cltbld', 02:06:46 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461055996.254335-530092315', 02:06:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:46 INFO - '_': '/tools/buildbot/bin/python'} 02:06:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:47 INFO - Downloading/unpacking flake8 02:06:47 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 02:06:47 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 02:06:47 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 02:06:47 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 02:06:47 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 02:06:47 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 02:06:48 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:06:48 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:06:48 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 02:06:48 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 02:06:48 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 02:06:48 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 02:06:48 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 02:06:48 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 02:06:49 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:06:49 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:06:49 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 02:06:49 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 02:06:49 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 02:06:49 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 02:06:49 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 02:06:49 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 02:06:49 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:06:49 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 02:06:49 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 02:06:49 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 02:06:49 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 02:06:49 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 02:06:49 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 02:06:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:06:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:06:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:06:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:06:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:06:49 INFO - no previously-included directories found matching 'docs/_build' 02:06:49 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:06:49 INFO - Running setup.py install for pep8 02:06:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:06:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:06:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:06:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:06:49 INFO - no previously-included directories found matching 'docs/_build' 02:06:49 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:06:49 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:06:49 INFO - Cleaning up... 02:06:49 INFO - Return code: 0 02:06:49 INFO - Running post-action listener: _resource_record_post_action 02:06:49 INFO - Running post-action listener: _start_resource_monitoring 02:06:49 INFO - Starting resource monitoring. 02:06:49 INFO - ##### 02:06:49 INFO - ##### Running install step. 02:06:49 INFO - ##### 02:06:49 INFO - Running pre-action listener: _resource_record_pre_action 02:06:49 INFO - Running main action method: install 02:06:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:06:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:06:50 INFO - Reading from file tmpfile_stdout 02:06:50 INFO - Detecting whether we're running mozinstall >=1.0... 02:06:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:06:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:06:50 INFO - Reading from file tmpfile_stdout 02:06:50 INFO - Output received: 02:06:50 INFO - Usage: mozinstall [options] installer 02:06:50 INFO - Options: 02:06:50 INFO - -h, --help show this help message and exit 02:06:50 INFO - -d DEST, --destination=DEST 02:06:50 INFO - Directory to install application into. [default: 02:06:50 INFO - "/builds/slave/test"] 02:06:50 INFO - --app=APP Application being installed. [default: firefox] 02:06:50 INFO - mkdir: /builds/slave/test/build/application 02:06:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:06:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:07:06 INFO - Reading from file tmpfile_stdout 02:07:06 INFO - Output received: 02:07:06 INFO - /builds/slave/test/build/application/firefox/firefox 02:07:06 INFO - Running post-action listener: _resource_record_post_action 02:07:06 INFO - ##### 02:07:06 INFO - ##### Running run-tests step. 02:07:06 INFO - ##### 02:07:06 INFO - Running pre-action listener: _resource_record_pre_action 02:07:06 INFO - Running main action method: run_tests 02:07:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:07:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:07:06 INFO - Python 2.7.3 02:07:06 INFO - Return code: 0 02:07:06 INFO - grabbing minidump binary from tooltool 02:07:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:06 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 0x1430810>, '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 0x1431710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1431ba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:07:06 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 02:07:06 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 02:07:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:07:06 INFO - Return code: 0 02:07:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:07:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:07:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:07:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:07:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:07:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:07:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:07:07 INFO - Return code: 0 02:07:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HNgas2hnQxasLDv-WckIjw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 02:07:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HNgas2hnQxasLDv-WckIjw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --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 02:07:07 INFO - Using env: {'DISPLAY': ':0', 02:07:07 INFO - 'HOME': '/home/cltbld', 02:07:07 INFO - 'LANG': 'en_US.UTF-8', 02:07:07 INFO - 'LANGUAGE': 'en_US:en', 02:07:07 INFO - 'LOGNAME': 'cltbld', 02:07:07 INFO - 'MAIL': '/var/mail/cltbld', 02:07:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:07:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:07:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:07 INFO - 'MOZ_NO_REMOTE': '1', 02:07:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:07:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:07 INFO - 'NO_EM_RESTART': '1', 02:07:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:07 INFO - 'PWD': '/builds/slave/test', 02:07:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:07:07 INFO - 'SHELL': '/bin/bash', 02:07:07 INFO - 'SHLVL': '1', 02:07:07 INFO - 'TERM': 'linux', 02:07:07 INFO - 'TMOUT': '86400', 02:07:07 INFO - 'USER': 'cltbld', 02:07:07 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461055996.254335-530092315', 02:07:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:07 INFO - '_': '/tools/buildbot/bin/python'} 02:07:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HNgas2hnQxasLDv-WckIjw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 02:07:08 INFO - mozversion application_buildid: 20160418233037 02:07:08 INFO - mozversion application_changeset: 9a8ff2f4978493c3fd9982652a09ffcdf2333a75 02:07:08 INFO - mozversion application_display_name: Nightly 02:07:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:07:08 INFO - mozversion application_name: Firefox 02:07:08 INFO - mozversion application_remotingname: firefox 02:07:08 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:07:08 INFO - mozversion application_vendor: Mozilla 02:07:08 INFO - mozversion application_version: 48.0a1 02:07:08 INFO - mozversion platform_buildid: 20160418233037 02:07:08 INFO - mozversion platform_changeset: 9a8ff2f4978493c3fd9982652a09ffcdf2333a75 02:07:08 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:07:08 INFO - mozversion platform_version: 48.0a1 02:07:08 INFO - using testdate: 1461056828 02:07:08 INFO - actual date: 1461056828 02:07:08 INFO - starting webserver on 'localhost:36562' 02:07:08 INFO - SUITE-START | Running 2 tests 02:07:08 INFO - TEST-START | dromaeo_css 02:07:08 INFO - operating with platform_type : linux_ 02:07:08 INFO - Initialising browser for dromaeo_css test... 02:07:08 INFO - TEST-INFO | started process 8558 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmX_Wse/profile http://localhost:36562/getInfo.html) 02:07:12 INFO - PROCESS | 8558 | __metrics Screen width/height:1600/1200 02:07:12 INFO - PROCESS | 8558 | colorDepth:24 02:07:12 INFO - PROCESS | 8558 | Browser inner width/height: 1024/697 02:07:12 INFO - PROCESS | 8558 | __metrics 02:07:13 ERROR - PROCESS | 8558 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:07:14 INFO - TEST-INFO | 8558: exit 0 02:07:14 INFO - Browser initialized. 02:07:14 INFO - Running cycle 1/1 for dromaeo_css test... 02:07:14 INFO - TEST-INFO | started process 8640 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmX_Wse/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:07:26 INFO - PROCESS | 8640 | RSS: Main: 153419776 02:07:26 INFO - PROCESS | 8640 | 02:08:16 INFO - PROCESS | 8640 | 1461056896785 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] 02:10:24 INFO - PROCESS | 8640 | Cycle 1(1): loaded http://localhost:36562/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36562/tests/dromaeo/cssquery-ext.html) 02:10:25 INFO - PROCESS | 8640 | RSS: Main: 271167488 02:10:25 INFO - PROCESS | 8640 | 02:13:27 INFO - PROCESS | 8640 | Cycle 1(1): loaded http://localhost:36562/tests/dromaeo/cssquery-ext.html (next: http://localhost:36562/tests/dromaeo/cssquery-jquery.html) 02:13:28 INFO - PROCESS | 8640 | RSS: Main: 237625344 02:13:28 INFO - PROCESS | 8640 | 02:16:30 INFO - PROCESS | 8640 | Cycle 1(1): loaded http://localhost:36562/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36562/tests/dromaeo/cssquery-mootools.html) 02:16:31 INFO - PROCESS | 8640 | RSS: Main: 240988160 02:16:31 INFO - PROCESS | 8640 | 02:19:33 INFO - PROCESS | 8640 | Cycle 1(1): loaded http://localhost:36562/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36562/tests/dromaeo/cssquery-prototype.html) 02:19:33 INFO - PROCESS | 8640 | RSS: Main: 230014976 02:19:33 INFO - PROCESS | 8640 | 02:22:36 INFO - PROCESS | 8640 | Cycle 1(1): loaded http://localhost:36562/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36562/tests/dromaeo/cssquery-yui.html) 02:22:36 INFO - PROCESS | 8640 | RSS: Main: 225873920 02:22:36 INFO - PROCESS | 8640 | 02:25:39 INFO - PROCESS | 8640 | Cycle 1(1): loaded http://localhost:36562/tests/dromaeo/cssquery-yui.html (next: http://localhost:36562/tests/dromaeo/cssquery-dojo.html) 02:25:39 INFO - PROCESS | 8640 | RSS: Main: 266588160 02:25:39 INFO - PROCESS | 8640 | 02:25:39 INFO - PROCESS | 8640 | __start_tp_report 02:25:39 INFO - PROCESS | 8640 | _x_x_mozilla_page_load 02:25:39 INFO - PROCESS | 8640 | _x_x_mozilla_page_load_details 02:25:39 INFO - PROCESS | 8640 | |i|pagename|runs| 02:25:39 INFO - PROCESS | 8640 | |0;dojo.html;3012.4426981008514;3033.3326668133004;3066.8926587569426;3075.5079187330016;3105.021918095799;5048.697078175312;5153.149730294506;5171.508706672865;5177.585793136544;5218.8695282617955;5228.372595288562;5232.2674825524455;5249.527542521172;5331.280277162582;5336.67979921204;4677.204875171212;4752.667313288071;4806.543378379049;4867.221244600864;4874.000829829876;4804.423469183703;4816.903661926759;4819.903601927959;4867.221244600864;4917.4836642152595;4643.512431194727;4749.358836557055;4813.518648135194;4820.132376172288;4839.249916262985;4796.808127674889;4797.832075877328;4801.855944321676;4820.903581928342;4832.444268909086;4660.1145782301255;4745.833895813665;4764.547368000034;4775.092732380836;4841.104395686809;5030.0694371541385;5031.823886163967;5037.974810125963;5057.216131499624;5063.038022775698;5416.160495123262;5428.321459817523;5547.5007249347345;5639.577031722637;5659.009673307155;5638.971805140989;5642.294713160855;5646.2942132233475;5646.40712725162;5694.886102277931;5245.973770131125;5263.736813159365;5266.210068489719;5266.236395722637;5268.446813084571;5474.151506516497;5686.545076393962;5738.024535828919;5751.194832723422;5798.5651076168615;5438.945610543844;5445.891082178334;5477.233187353773;5491.972540137273;5504.834854954358;5552;5552.250446189793;5568.192612071227;5570.303712035996;5571.66570005801;5302.655327403706;5504.972475137679;5580.693061881554;5631.267935168402;5670.234518339971;5589.273394458775;5603.439656034446;5610.775568977277;5611.691356975324;5616.887662246814;4088.182363527247;4245.957540424618;4251.341042138473;4252.128313695685;4297.312430011246;3749.1189570450924;3777.036855601804;3790.469334293201;3831.750936189139;3838.5393752749846;5307.52232299095;5341.732913354317;5342.1185504392115;5346.97326513365;5348.1175606025345;5444.972775136099;5613.242212301368;5619.466150715675;5625.578081643893;5670.319561652628;5326.121190003683;5350.8662283442445;5352.384475785335;5361.356637203483;5403.9459605403445;4823.614110871122;4824.252240902595;4825.806967721252;4840.733759643183;4864.73243971585;5533.861653458695;5706.657600543981;5797.072468405035;5802.042662960649;5809.622374545641;5636.802711905064;5645;5646.435356464321;5668.234788303609;5673.432656734459;5798.362180160263;5803.7968671096305;5810.564207684525;5811.389804070512;5815.709214539172;5282.867928301823;5464.91802622953;5524.613277070566;5530.640508366943;5555.30558680165;5548.750306236148;5556.083246264321;5558.888822223452;5559.388467268678;5586.776528938797;5400.9459905400445;5408.432114627907;5413.998410294108;5421.512063914267;5445.754941027584;5248.947510524846;5404.378496472956;5423.050966080999;5498.80754173602;5516.503514683698;5371.355437347387;5375.650582712111;5408.810691625774;5427.782888684408;5429.077056900257;5499.1476321170285;5513.365962914156;5525.171224316385;5543.8891222174525;5595.608307418442;5159.947414548557;5229.346331708536;5348.973255133699;5355.143177091647;5420.53925416344 02:25:39 INFO - PROCESS | 8640 | |1;ext.html;605.3734384911618;652.2303681655648;653.9210303000052;654.5745265577376;660.7621256347715;27828.165155045357;36155.81922090389;37110;37183.62816371836;37225.99999999996;39908;40422;40453.797731011306;40570.18859622806;40609;8505.74482765518;8723.25852302555;8724.956375218115;8727.95636021819;8732.08313127122;8666.86999695002;8761.430507017023;8779.473231606124;8793.340499462534;8798.164174403422;8833.469991800512;8905.910940890606;8909.777255568597;8917.063708310632;8919.331050171264;8773.210411063003;8814.735557933273;8831.514266715329;8837.867431988494;8842.292616590657;8656.913430865736;8721.171488708562;8776.912230877737;8788;8791.692290769857;39367.40948885769;39764.60235397638;39792.20415591701;39896;39903.201935961115;3416.982915085409;3439.9312013759836;3641.635836416364;3772.962270377316;4103.220388126277;30827.845860770776;30922.381552368828;31128;31536.842315788275;32388.67611323904;4034.3545032794614;4115.650169735576;4127.5666055064385;4228.92162498564;4334.306510958263;289849.9999999979;293018;293189;294192;295519;53989.73005134949;54274;54356.45643543593;54673.45326546763;54784;59394.40605593889;59562.70218648966;59674.40325596775;59714.402855971755;59790.70104649536;14384.85615143856;14499.565013049625;14583.85416145825;14597.343119559646;14604.05073670208;10060.748481288027;10066.09405153525;10088.949555252177;10091.798164036678;10104.393736375841;15388.769168462482;16719.414820481226;16776.328946842234;16813.327466901188;16831.831681683027;4918.794430761719;5795.710214489259;5818.912716309259;5880.971064982574;5991.310999235056;1043.7683533430472;1105.40308233553;1131.9264247823864;1138.248755821154;1178.8231765235284;27834.222208980143;28082.157535273975;28510.86168537368;29917;29997.400051998837;1122.6014764758393;1150.1546363422879;1160.9593664221711;1180.9704757381135;1185.25921299188;15618.45335413255;16022.839771602135;16049.197540122947;16135.047013191555;16172.94631226189;398250;407646;409697;410344;413061;56093.7195314029;56314.71842640843;56470.717646411504;56772.432275676714;56776.43223567794;745.1238220468986;1189.3220864107375;1218.06817784395;1291.7481091187128;1422.964425889361;29706;31388;31464.37071258516;31512.2121946944;32005.6799432012;44245.55754442414;44769.328460073775;44819;44845.32732008957;44867.65397038094;277747;279291;280012;280065;280437;26369.472610548066;27791.16626501208;27809.860950695118;27855.721442785314;27894.721052789213;44596.77701611471;45096;45425.318620221384;45468.545314546434;45521.089578208914;39313;39757.20485590214;39833.80083099566;40137.59862401456;40142.598574013886;38188;38932.80533597427;39550.40674389829;39625.40561891516;39696;40052.39921401123;40277.597224027384;41500.37749433701;42913;42928.57071429371;30315.696843031288;31954.36091278115;32465;32780.50829237611;32864.1783955403;25145.805629018712;26895.193144205707;27454.588181177696;27462.450750985266;27562.724372756016 02:25:39 INFO - PROCESS | 8640 | |2;jquery.html;373.3745975491052;392.2879972849278;394.57780175212537;396.6430212808472;405.3534612293392;16711;17641.91179044103;18401.263949442007;18590.62818743626;18604;16772.66454670906;17258;17602.823971760277;17846.910765446155;17886.64226715465;5507.228987941681;5641.435856414367;5659.943400566003;5669.971650141743;5672.205891175238;3833.3674943634405;5843.094320380348;6181.598196117238;6181.660008699542;6188.876222475547;5918.940810591882;6112.052631842072;6124.938750612481;6133.723982420802;6166.6916654167335;3907.1013666856497;6027.849303767441;6053.878922421571;6105.969470152643;6109.144719739218;5131.486851314876;5456.48163424474;5465.945340546623;5472.480114389126;5474.863128421821;20272.391828245178;20423.591528169352;21866.453338666503;22124.668129978065;22168;2286.2341115726254;2333.56828986638;2429.8906549205153;2435.926922192337;2464.1621848571394;9066.5920033598;13946.723974211645;14199;14514.637134071627;14546.92726536371;1906.8665193436466;1915.9042047897549;1931.6040211756556;1955.285037991813;2066.700328452381;76750;79706;81362.59318703428;81933;82653;10516.789664206826;10610.151187904949;10794.352338859693;11115.388653624128;11296.37869917146;15047.473338433103;15157.242137893281;15161.317740701696;15192.772108418383;15198.46805361807;7416.592087435243;7540.283673051052;7618.123915749649;7687.961560192163;7755.92244077552;7073.257307982588;7122.71509139639;7142.964285178645;7264.600446975467;7295.927040729631;4120.49601895306;4405.867823965286;4482.932756008662;4536.160810250049;4658.836940707059;1809.511431913376;1871.5695390060362;1876.3245231716571;1882.6328865871023;1942.796006419334;910.7996240827008;997.645835728306;1013.7871047080048;1042.3849928542197;1052.2371280821496;17526.123693815258;17755.46733597994;17774.91112544429;18087.638247234983;18384.724229136573;974.541965276319;992.5136683025265;1035.7669524357111;1043.4782608695652;1047.7223535763028;9743.220542356594;9921.454320012468;10001.099901008944;10013.39919604826;10033.648822291185;448448;456792;470237;474746;476349;87964;90731;91060;91389.54305228431;91496.08503914876;1096.2162054131175;1106.336198281025;1116.815725405299;1117.8155604325195;1119.3787447966295;15715.764263535828;15974.121423321363;15986.920065399598;16058.598535036717;16138.112403817902;34521.30957380788;34836;35229.82385088058;35805;35965;51877.7406112967;52985;53010.46989530055;53672.19491707705;53991;8035.83928321442;8227;8379.832403351777;8500.44747091437;8667.696630617898;7281.927180728125;12322.383880806103;12356;12542.12205145631;13245.668858278621;10954.890451095387;10992;10993.230473866752;11342.886571134182;11362.204645674723;10934.61211848731;11059.668209953392;11063.391513466837;11350.772984540428;11398.658040258806;11004.22970392097;11010.50452729645;11430.885691142983;11703.531858725897;11785.941070294593;8167.305779008851;8215.58922053883;8265.504069755834;8419.368547359096;8429.831403372022;10348.379097254188;11241.55033798639;11426.542938282375;11635.709107272385;11797.29216247028 02:25:39 INFO - PROCESS | 8640 | |3;mootools.html;1329.0962145740893;1527.4653871145101;1546.0028281758266;1738.4697667211503;1864.6643604151263;8105.91894081059;8443.282321002715;8445.366597505197;8456.915430845698;8467.788305292372;8252.752417427471;8408.327333813295;8415.410921235516;8428;8437.114103019172;2005.4886004068942;2286.314105768267;2287.942801429961;2311.884405779713;2370.2533701883935;2317.5944209763306;2338.6608941703444;2339.4385347516645;2339.6256598944174;2340.5318936212825;2252.4706693926914;2267.4218074391006;2289.305913623923;2296.0700916128912;2297;1970.5467742419253;2255.86464812111;2337.146941366406;2337.1586228957563;2340.0873659272897;2278.532900755358;2292.4956509568037;2293.1515339324555;2305.4927915858652;2319.373769082338;8311.709090181876;8397.70608028716;8424.578771061484;8429.199226073575;8436.156384361577;5027.145385284511;5173.198154286091;5175.146100893348;5187.170052791573;5261.552768014723;3164.17731389838;3189.61724593048;3222.274988127676;3235.0780027691994;3282.556854824616;1046.4453839465095;1051.3481641382316;1085.8914108589156;1102.7077824376547;1104.1498046504228;11989.820152697717;11991.700207494796;11999.460024298927;12001.639950801577;12009.279443233434;4410.845620403271;4416.403785488982;4589.2657174851865;4593.839215627504;4612.169809434334;10120.190384769201;10122.493875306205;10126.949365253127;10130.797384052277;10138.290319677551;4475.843345482893;5166.121759300928;5170.71561064145;5174.197999310113;5178.482151784867;4492.460904691393;4555.886102847456;4578.267477203632;4597.471290801601;4600.240960241589;3887.9611203888167;3956;3966.0679740261016;3974.324364857981;3995.900102497461;1269.0735762892955;1270.84749830021;1273.6752128207247;1284.3578210894552;1293.043148070421;953.2993249961273;960.3037797596826;969.7817990951979;989.6585677941099;1003.4330603209163;5788.247527821441;5808.273965754281;5851.444112809277;5938.762449502058;5972.313183983897;1010.6715317521835;1017.5471914997903;1017.5980487707315;1031.3502493429091;1044.8484969679505;3982.6017398260524;4076.3681629347498;4076.5515793262716;4089.2026054919006;4100.220958017967;10133.695989120191;10616.575336986589;10639.361638301727;10650.467476626138;10685.679429617125;10610.628627997983;10708.303960242714;10713;10846.29499082557;10897.455127243606;7569.545827250383;7969.641366138538;7975.122736498981;8006.759797206093;8024.638891249791;5718.1130227025815;5890.823275301748;5898;6036.788712395045;6075.665838378754;9534.23726101924;9594.088561586637;9687.70936871895;9698.660546881107;9724.951375243361;9583.616655333708;9806.705798826046;10067.194624430174;10170.93205213442;10236.283460157718;6735.730570777114;6955.1653801544135;7116.750913717995;7204.351608355064;7478.887816682863;7913.643886025257;7954.681812727426;7969.043714754266;7996.56018918965;8000;6707.5304728668525;6824.146981627297;6862.005009273727;7007.6145811978795;7072.045273887959;6871.690773915286;6883.586984780729;6943.722251109899;6958.443324533924;6995.685194166173;6671.733130674718;6699.263081060982;6725.831854203684;6732.730690772511;6771.153605799275;5010.121204548294;5041.798328066836;5093.567046801063;5154.819581314636;5187.870303242449;4977.60179185657;5051.191809310492;5116.820911268088;5136;5184.274201611853 02:25:39 INFO - PROCESS | 8640 | |4;prototype.html;321.65422171166;323.86235849763847;331.8357413080525;333.73801565770844;335.7666421836823;5556.583256255777;5595.608307418483;5603.887922241553;5645.125005624124;5670.177824215497;5591.133374326976;5603.271574695284;5603.861837371075;5609.3268807743125;5622.578306627009;4104.15864747726;4157.584241575833;4327.870163895088;4360.324149756792;4368.628666563346;4314.719543229696;4332.292317301686;4342.131573685259;4349.782510874444;4362.607365337119;4141.792910354486;4296.57034296571;4299.978500107511;4311.892202694942;4313.439252897119;4143.689223308249;4298.226319262531;4312.547182545819;4327.307630779061;4333.241682705546;3763;3771.4531392948143;3785.6971442284826;3786.5266841644793;3789.1853251550774;5309.65487243328;5418.133098704188;5425.046983086086;5439.80324328647;5449.182622606601;4921.901561968776;4956.157453232923;4976.303317535548;4983.875403114951;4992.800287988476;5778.913316300217;5814.156947242626;5815.79644712433;5837.620554663933;5847.122931560258;4000.6799456043445;4149.668026557868;4162.937555936664;4166.749995000279;4170.249355116078;6095.542834287447;6098.878022439526;6106.450419462225;6115.510759139258;6146.108814221912;4215.957840421618;4250.341197114452;4265.997490589709;4267.850625228102;4274.551172126882;4226.429432026637;4325.5674432557125;4327.112941846914;4335.609795118455;4354.455693038371;4937.086638971802;4946.1344264753525;4952.306677065214;4955;4962.032403681247;5864.794732184353;5884.735186916599;5897.380775018647;5911.379305172981;5916.349201587822;1474.837767845536;1490.4857824050684;1506.8041154650045;1514.4169494744604;1518.468536012409;936.7096200177966;1006.6476733143342;1015.6496008876926;1024.7335692719946;1036.5957276662107;5598.4961353477565;5600.52395546375;5678.744456499468;5686.402927692616;5701.771929122789;5943.197668314809;5963.671998040063;5995.910061349084;5996.400359963969;6033.698315084316;5561.555075593943;5673.404292549306;5766.336871259775;5778.422157784188;5790.94209057904;3186.4901615741833;3259.7718159729066;3268.7251971731043;3284.178955261185;3291.8683252669625;6133.938660613426;6309;6322.778702745474;6399.104125422445;6414.550981431255;6136.018237082135;6181.505479561624;6207;6232.937670623326;6268.028455589391;6127.20346354971;6316.463100636405;6320.55756097078;6321.747130114744;6333.429991300805;6083.756649733961;6129.141920131275;6132.2947860996555;6137.723802428812;6141.201643786458;6056.788012419544;6057.454829065406;6059.454649081604;6079.969600151971;6080.604760690541;6105.633661980295;6280.142535146589;6309.1734822859635;6310;6358.237011558643;4260.211860805637;4273.316269396882;4280.636145927631;4282.0793529390085;4291.549387314287;5893.543696089502;6065.605735627347;6071.089336599545;6073.240844894388;6104.816855494342;5827.358990511125;5849.970750146222;5855.824325270249;5891.116332550152;5903.852403689771;5887.675273063698;5892.234009578728;5909.674967876808;5921.467067963904;5925;5683.8010669626365;5793.768249269982;5803.158542011469;5849.181114644039;5864.120381942743;5953.791617293374;5975;6001.309849367379;6004.849878753066;6010.106816352835;5634.605577609692;5836.474717275466;5840.795572154954;5865.970670146793;5875.294964604275 02:25:39 INFO - PROCESS | 8640 | |5;yui.html;800.6717245929169;855.2302927365374;868.3574155125209;873.7247766953409;874.3966663002528;13516.526921557748;13817.51638692646;13836.377363018662;16311.429099981504;16556.254968526417;15425;15501.689966200669;15550;15558.844411555881;15583.454579089734;653.3140202787079;817.697451942782;840.3445312656138;847.0936098374741;847.9576021198947;830.887830142929;834.5493433545878;837.1335667584052;837.7403005068418;838.6226198210829;864.6973559254242;871.877937088808;875.4703404440286;875.7241468937297;876.8903887014123;679.3478260869571;701.2426579294375;702.4801646781345;841.5455653946862;867.6616119713285;629.1192330736959;631.1700114349616;632.5477283742147;633.8985762278013;635.841039740065;14685.632859178499;14731.852681473156;14749.188794616291;14764.26178691061;14785.556433307018;13272.668183295495;13513.325516227167;13641.795373069412;13661.658458538517;13720.245386503739;11632;11749.88250117505;12086.818697719542;12227.877721222763;12258.20321679097;3883.650471457582;3923.3330333843314;3944.684425245973;3959.0696186396176;4023.2556976959063;56456;59296;59848;60686.39313606852;61340.38659613436;10812.567497300177;10833.133349332034;10872.78254434907;11007.724806879893;11131.443427828739;19709.507262318555;19740.11169497376;19784.406467805988;19806.405807825788;20395.184192632427;8234.958825205955;8275.793105172419;8331.458455200393;8356;8442.113578074337;4591.357209990604;4720.126776546282;4724.4094488188975;4760.809567617326;4798.66409351349;3330.6169790473923;3427.503012063287;3428.5542879425516;3428.674275943781;3431.227973705896;634.8254230086764;658.9736410543525;670.5373292428209;674.8414122681166;676.6143298319911;711.2922641971272;718.9568625882464;735.5696917303437;748.5508694783196;749.8987636668979;9057.292081971145;9319.720408387759;9372.67195648149;9489.857652135224;9712.368696034735;712.6472396163829;713.2902761751986;720.4632548751109;728.1953441447231;729.5221629832469;4260.510041345285;4286.807093680792;4363.498197707241;4472.217361961643;4557.339185818038;61172.38827611756;61465.38534614686;62088.379116209166;62616.425275345435;64455.35544644587;52769.472305277224;53685.46314536883;54761;55174.44825551693;55486;48884;49584;49975;50555.49444505582;52346.999999999236;8873.600687968928;9109.544522773702;9121.270298375981;9121.635134594542;9128;32825.83587082145;33424.33151336911;33817.49273760945;33987.3202535943;34222.828885856405;42375;46364;46566;47312.52687473219;47528.52471475241;12123.151379403356;12208.511659533875;12244.265344079384;12308.815367769312;12385.442655080362;12594.748105038032;12835.743285134431;13101.541446049343;13648.317584120952;13719.862801371859;10867.836982445111;12177.452014659539;12493.312867792358;13205.405756740778;13637;11899.345535995604;12034.037277017642;12106.697332566757;12132;12178.512859485876;12614.747705046031;12815.295158766357;12917.547885824328;12958.935205323913;13058.477660893457;9644.01165343019;10068.29521933487;10117.392956422638;10199.0820826126;10400.167986561208;11585.942070289595;11598.826017609912;11643.417829108681;11658.10035948759;11862.110341724232 02:25:39 INFO - PROCESS | 8640 | __end_tp_report 02:25:39 INFO - PROCESS | 8640 | __start_cc_report 02:25:39 INFO - PROCESS | 8640 | _x_x_mozilla_cycle_collect,947 02:25:39 INFO - PROCESS | 8640 | __end_cc_report 02:25:39 INFO - PROCESS | 8640 | __startTimestamp1461057939413__endTimestamp 02:25:39 INFO - PROCESS | 8640 | 02:25:39 INFO - PROCESS | 8640 | ------- Summary: start ------- 02:25:39 INFO - PROCESS | 8640 | Number of tests: 6 02:25:39 INFO - PROCESS | 8640 | 02:25:39 INFO - PROCESS | 8640 | [#0] dojo.html Cycles:165 Average:5190.61 Median:5375.65 stddev:583.55 (10.9%) stddev-sans-first:559.76 02:25:39 INFO - PROCESS | 8640 | Values: 3012.4 3033.3 3066.9 3075.5 3105.0 5048.7 5153.1 5171.5 5177.6 5218.9 5228.4 5232.3 5249.5 5331.3 5336.7 4677.2 4752.7 4806.5 4867.2 4874.0 4804.4 4816.9 4819.9 4867.2 4917.5 4643.5 4749.4 4813.5 4820.1 4839.2 4796.8 4797.8 4801.9 4820.9 4832.4 4660.1 4745.8 4764.5 4775.1 4841.1 5030.1 5031.8 5038.0 5057.2 5063.0 5416.2 5428.3 5547.5 5639.6 5659.0 5639.0 5642.3 5646.3 5646.4 5694.9 5246.0 5263.7 5266.2 5266.2 5268.4 5474.2 5686.5 5738.0 5751.2 5798.6 5438.9 5445.9 5477.2 5492.0 5504.8 5552.0 5552.3 5568.2 5570.3 5571.7 5302.7 5505.0 5580.7 5631.3 5670.2 5589.3 5603.4 5610.8 5611.7 5616.9 4088.2 4246.0 4251.3 4252.1 4297.3 3749.1 3777.0 3790.5 3831.8 3838.5 5307.5 5341.7 5342.1 5347.0 5348.1 5445.0 5613.2 5619.5 5625.6 5670.3 5326.1 5350.9 5352.4 5361.4 5403.9 4823.6 4824.3 4825.8 4840.7 4864.7 5533.9 5706.7 5797.1 5802.0 5809.6 5636.8 5645.0 5646.4 5668.2 5673.4 5798.4 5803.8 5810.6 5811.4 5815.7 5282.9 5464.9 5524.6 5530.6 5555.3 5548.8 5556.1 5558.9 5559.4 5586.8 5400.9 5408.4 5414.0 5421.5 5445.8 5248.9 5404.4 5423.1 5498.8 5516.5 5371.4 5375.7 5408.8 5427.8 5429.1 5499.1 5513.4 5525.2 5543.9 5595.6 5159.9 5229.3 5349.0 5355.1 5420.5 02:25:39 INFO - PROCESS | 8640 | 02:25:39 INFO - PROCESS | 8640 | [#1] ext.html Cycles:180 Average:49259.74 Median:39760.90 stddev:87277.46 (219.5%) stddev-sans-first:87445.84 02:25:39 INFO - PROCESS | 8640 | Values: 605.4 652.2 653.9 654.6 660.8 27828.2 36155.8 37110.0 37183.6 37226.0 39908.0 40422.0 40453.8 40570.2 40609.0 8505.7 8723.3 8725.0 8728.0 8732.1 8666.9 8761.4 8779.5 8793.3 8798.2 8833.5 8905.9 8909.8 8917.1 8919.3 8773.2 8814.7 8831.5 8837.9 8842.3 8656.9 8721.2 8776.9 8788.0 8791.7 39367.4 39764.6 39792.2 39896.0 39903.2 3417.0 3439.9 3641.6 3773.0 4103.2 30827.8 30922.4 31128.0 31536.8 32388.7 4034.4 4115.7 4127.6 4228.9 4334.3 289850.0 293018.0 293189.0 294192.0 295519.0 53989.7 54274.0 54356.5 54673.5 54784.0 59394.4 59562.7 59674.4 59714.4 59790.7 14384.9 14499.6 14583.9 14597.3 14604.1 10060.7 10066.1 10088.9 10091.8 10104.4 15388.8 16719.4 16776.3 16813.3 16831.8 4918.8 5795.7 5818.9 5881.0 5991.3 1043.8 1105.4 1131.9 1138.2 1178.8 27834.2 28082.2 28510.9 29917.0 29997.4 1122.6 1150.2 1161.0 1181.0 1185.3 15618.5 16022.8 16049.2 16135.0 16172.9 398250.0 407646.0 409697.0 410344.0 413061.0 56093.7 56314.7 56470.7 56772.4 56776.4 745.1 1189.3 1218.1 1291.7 1423.0 29706.0 31388.0 31464.4 31512.2 32005.7 44245.6 44769.3 44819.0 44845.3 44867.7 277747.0 279291.0 280012.0 280065.0 280437.0 26369.5 27791.2 27809.9 27855.7 27894.7 44596.8 45096.0 45425.3 45468.5 45521.1 39313.0 39757.2 39833.8 40137.6 40142.6 38188.0 38932.8 39550.4 39625.4 39696.0 40052.4 40277.6 41500.4 42913.0 42928.6 30315.7 31954.4 32465.0 32780.5 32864.2 25145.8 26895.2 27454.6 27462.5 27562.7 02:25:39 INFO - PROCESS | 8640 | 02:25:39 INFO - PROCESS | 8640 | [#2] jquery.html Cycles:180 Average:27644.20 Median:2450.04 stddev:76816.94 (3135.3%) stddev-sans-first:77005.14 02:25:39 INFO - PROCESS | 8640 | Values: 373.4 392.3 394.6 396.6 405.4 16711.0 17641.9 18401.3 18590.6 18604.0 16772.7 17258.0 17602.8 17846.9 17886.6 5507.2 5641.4 5659.9 5670.0 5672.2 3833.4 5843.1 6181.6 6181.7 6188.9 5918.9 6112.1 6124.9 6133.7 6166.7 3907.1 6027.8 6053.9 6106.0 6109.1 5131.5 5456.5 5465.9 5472.5 5474.9 20272.4 20423.6 21866.5 22124.7 22168.0 2286.2 2333.6 2429.9 2435.9 2464.2 9066.6 13946.7 14199.0 14514.6 14546.9 1906.9 1915.9 1931.6 1955.3 2066.7 76750.0 79706.0 81362.6 81933.0 82653.0 10516.8 10610.2 10794.4 11115.4 11296.4 15047.5 15157.2 15161.3 15192.8 15198.5 7416.6 7540.3 7618.1 7688.0 7755.9 7073.3 7122.7 7143.0 7264.6 7295.9 4120.5 4405.9 4482.9 4536.2 4658.8 1809.5 1871.6 1876.3 1882.6 1942.8 910.8 997.6 1013.8 1042.4 1052.2 17526.1 17755.5 17774.9 18087.6 18384.7 974.5 992.5 1035.8 1043.5 1047.7 9743.2 9921.5 10001.1 10013.4 10033.6 448448.0 456792.0 470237.0 474746.0 476349.0 87964.0 90731.0 91060.0 91389.5 91496.1 1096.2 1106.3 1116.8 1117.8 1119.4 15715.8 15974.1 15986.9 16058.6 16138.1 34521.3 34836.0 35229.8 35805.0 35965.0 51877.7 52985.0 53010.5 53672.2 53991.0 8035.8 8227.0 8379.8 8500.4 8667.7 7281.9 12322.4 12356.0 12542.1 13245.7 10954.9 10992.0 10993.2 11342.9 11362.2 10934.6 11059.7 11063.4 11350.8 11398.7 11004.2 11010.5 11430.9 11703.5 11785.9 8167.3 8215.6 8265.5 8419.4 8429.8 10348.4 11241.6 11426.5 11635.7 11797.3 02:25:39 INFO - PROCESS | 8640 | 02:25:39 INFO - PROCESS | 8640 | [#3] mootools.html Cycles:180 Average:5600.65 Median:4591.55 stddev:3154.76 (68.7%) stddev-sans-first:3147.28 02:25:39 INFO - PROCESS | 8640 | Values: 1329.1 1527.5 1546.0 1738.5 1864.7 8105.9 8443.3 8445.4 8456.9 8467.8 8252.8 8408.3 8415.4 8428.0 8437.1 2005.5 2286.3 2287.9 2311.9 2370.3 2317.6 2338.7 2339.4 2339.6 2340.5 2252.5 2267.4 2289.3 2296.1 2297.0 1970.5 2255.9 2337.1 2337.2 2340.1 2278.5 2292.5 2293.2 2305.5 2319.4 8311.7 8397.7 8424.6 8429.2 8436.2 5027.1 5173.2 5175.1 5187.2 5261.6 3164.2 3189.6 3222.3 3235.1 3282.6 1046.4 1051.3 1085.9 1102.7 1104.1 11989.8 11991.7 11999.5 12001.6 12009.3 4410.8 4416.4 4589.3 4593.8 4612.2 10120.2 10122.5 10126.9 10130.8 10138.3 4475.8 5166.1 5170.7 5174.2 5178.5 4492.5 4555.9 4578.3 4597.5 4600.2 3888.0 3956.0 3966.1 3974.3 3995.9 1269.1 1270.8 1273.7 1284.4 1293.0 953.3 960.3 969.8 989.7 1003.4 5788.2 5808.3 5851.4 5938.8 5972.3 1010.7 1017.5 1017.6 1031.4 1044.8 3982.6 4076.4 4076.6 4089.2 4100.2 10133.7 10616.6 10639.4 10650.5 10685.7 10610.6 10708.3 10713.0 10846.3 10897.5 7569.5 7969.6 7975.1 8006.8 8024.6 5718.1 5890.8 5898.0 6036.8 6075.7 9534.2 9594.1 9687.7 9698.7 9725.0 9583.6 9806.7 10067.2 10170.9 10236.3 6735.7 6955.2 7116.8 7204.4 7478.9 7913.6 7954.7 7969.0 7996.6 8000.0 6707.5 6824.1 6862.0 7007.6 7072.0 6871.7 6883.6 6943.7 6958.4 6995.7 6671.7 6699.3 6725.8 6732.7 6771.2 5010.1 5041.8 5093.6 5154.8 5187.9 4977.6 5051.2 5116.8 5136.0 5184.3 02:25:39 INFO - PROCESS | 8640 | 02:25:39 INFO - PROCESS | 8640 | [#4] prototype.html Cycles:180 Average:4955.99 Median:5639.87 stddev:1478.13 (26.2%) stddev-sans-first:1440.77 02:25:39 INFO - PROCESS | 8640 | Values: 321.7 323.9 331.8 333.7 335.8 5556.6 5595.6 5603.9 5645.1 5670.2 5591.1 5603.3 5603.9 5609.3 5622.6 4104.2 4157.6 4327.9 4360.3 4368.6 4314.7 4332.3 4342.1 4349.8 4362.6 4141.8 4296.6 4300.0 4311.9 4313.4 4143.7 4298.2 4312.5 4327.3 4333.2 3763.0 3771.5 3785.7 3786.5 3789.2 5309.7 5418.1 5425.0 5439.8 5449.2 4921.9 4956.2 4976.3 4983.9 4992.8 5778.9 5814.2 5815.8 5837.6 5847.1 4000.7 4149.7 4162.9 4166.7 4170.2 6095.5 6098.9 6106.5 6115.5 6146.1 4216.0 4250.3 4266.0 4267.9 4274.6 4226.4 4325.6 4327.1 4335.6 4354.5 4937.1 4946.1 4952.3 4955.0 4962.0 5864.8 5884.7 5897.4 5911.4 5916.3 1474.8 1490.5 1506.8 1514.4 1518.5 936.7 1006.6 1015.6 1024.7 1036.6 5598.5 5600.5 5678.7 5686.4 5701.8 5943.2 5963.7 5995.9 5996.4 6033.7 5561.6 5673.4 5766.3 5778.4 5790.9 3186.5 3259.8 3268.7 3284.2 3291.9 6133.9 6309.0 6322.8 6399.1 6414.6 6136.0 6181.5 6207.0 6232.9 6268.0 6127.2 6316.5 6320.6 6321.7 6333.4 6083.8 6129.1 6132.3 6137.7 6141.2 6056.8 6057.5 6059.5 6080.0 6080.6 6105.6 6280.1 6309.2 6310.0 6358.2 4260.2 4273.3 4280.6 4282.1 4291.5 5893.5 6065.6 6071.1 6073.2 6104.8 5827.4 5850.0 5855.8 5891.1 5903.9 5887.7 5892.2 5909.7 5921.5 5925.0 5683.8 5793.8 5803.2 5849.2 5864.1 5953.8 5975.0 6001.3 6004.8 6010.1 5634.6 5836.5 5840.8 5866.0 5875.3 02:25:39 INFO - PROCESS | 8640 | 02:25:39 INFO - PROCESS | 8640 | [#5] yui.html Cycles:180 Average:15066.50 Median:25477.68 stddev:17426.36 (68.4%) stddev-sans-first:17442.31 02:25:39 INFO - PROCESS | 8640 | Values: 800.7 855.2 868.4 873.7 874.4 13516.5 13817.5 13836.4 16311.4 16556.3 15425.0 15501.7 15550.0 15558.8 15583.5 653.3 817.7 840.3 847.1 848.0 830.9 834.5 837.1 837.7 838.6 864.7 871.9 875.5 875.7 876.9 679.3 701.2 702.5 841.5 867.7 629.1 631.2 632.5 633.9 635.8 14685.6 14731.9 14749.2 14764.3 14785.6 13272.7 13513.3 13641.8 13661.7 13720.2 11632.0 11749.9 12086.8 12227.9 12258.2 3883.7 3923.3 3944.7 3959.1 4023.3 56456.0 59296.0 59848.0 60686.4 61340.4 10812.6 10833.1 10872.8 11007.7 11131.4 19709.5 19740.1 19784.4 19806.4 20395.2 8235.0 8275.8 8331.5 8356.0 8442.1 4591.4 4720.1 4724.4 4760.8 4798.7 3330.6 3427.5 3428.6 3428.7 3431.2 634.8 659.0 670.5 674.8 676.6 711.3 719.0 735.6 748.6 749.9 9057.3 9319.7 9372.7 9489.9 9712.4 712.6 713.3 720.5 728.2 729.5 4260.5 4286.8 4363.5 4472.2 4557.3 61172.4 61465.4 62088.4 62616.4 64455.4 52769.5 53685.5 54761.0 55174.4 55486.0 48884.0 49584.0 49975.0 50555.5 52347.0 8873.6 9109.5 9121.3 9121.6 9128.0 32825.8 33424.3 33817.5 33987.3 34222.8 42375.0 46364.0 46566.0 47312.5 47528.5 12123.2 12208.5 12244.3 12308.8 12385.4 12594.7 12835.7 13101.5 13648.3 13719.9 10867.8 12177.5 12493.3 13205.4 13637.0 11899.3 12034.0 12106.7 12132.0 12178.5 12614.7 12815.3 12917.5 12958.9 13058.5 9644.0 10068.3 10117.4 10199.1 10400.2 11585.9 11598.8 11643.4 11658.1 11862.1 02:25:39 INFO - PROCESS | 8640 | -------- Summary: end -------- 02:25:39 INFO - PROCESS | 8640 | 02:25:39 INFO - TEST-INFO | 8640: exit 0 02:25:40 INFO - TEST-OK | dromaeo_css | took 1111970ms 02:25:40 INFO - TEST-START | kraken 02:25:40 INFO - operating with platform_type : linux_ 02:25:40 INFO - Initialising browser for kraken test... 02:25:40 INFO - TEST-INFO | started process 8831 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptIuL2i/profile http://localhost:36562/getInfo.html) 02:25:43 INFO - PROCESS | 8831 | __metrics Screen width/height:1600/1200 02:25:43 INFO - PROCESS | 8831 | colorDepth:24 02:25:43 INFO - PROCESS | 8831 | Browser inner width/height: 1024/697 02:25:43 INFO - PROCESS | 8831 | __metrics 02:25:45 ERROR - PROCESS | 8831 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:25:45 INFO - TEST-INFO | 8831: exit 0 02:25:45 INFO - Browser initialized. 02:25:45 INFO - Running cycle 1/1 for kraken test... 02:25:45 INFO - TEST-INFO | started process 8914 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptIuL2i/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:25:57 INFO - PROCESS | 8914 | RSS: Main: 152739840 02:25:57 INFO - PROCESS | 8914 | 02:26:00 INFO - PROCESS | 8914 | Cycle 1(1): loaded http://localhost:36562/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36562/tests/kraken/driver.html?testName=audio-beat-detection) 02:26:00 INFO - PROCESS | 8914 | RSS: Main: 208531456 02:26:00 INFO - PROCESS | 8914 | 02:26:03 INFO - PROCESS | 8914 | Cycle 1(1): loaded http://localhost:36562/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36562/tests/kraken/driver.html?testName=audio-dft) 02:26:04 INFO - PROCESS | 8914 | RSS: Main: 194793472 02:26:04 INFO - PROCESS | 8914 | 02:26:07 INFO - PROCESS | 8914 | Cycle 1(1): loaded http://localhost:36562/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36562/tests/kraken/driver.html?testName=audio-fft) 02:26:07 INFO - PROCESS | 8914 | RSS: Main: 263798784 02:26:07 INFO - PROCESS | 8914 | 02:26:10 INFO - PROCESS | 8914 | Cycle 1(1): loaded http://localhost:36562/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36562/tests/kraken/driver.html?testName=audio-oscillator) 02:26:10 INFO - PROCESS | 8914 | RSS: Main: 173101056 02:26:10 INFO - PROCESS | 8914 | 02:26:12 INFO - PROCESS | 8914 | Cycle 1(1): loaded http://localhost:36562/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36562/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:26:13 INFO - PROCESS | 8914 | RSS: Main: 177881088 02:26:13 INFO - PROCESS | 8914 | 02:26:16 INFO - PROCESS | 8914 | Cycle 1(1): loaded http://localhost:36562/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36562/tests/kraken/driver.html?testName=imaging-darkroom) 02:26:17 INFO - PROCESS | 8914 | RSS: Main: 213622784 02:26:17 INFO - PROCESS | 8914 | 02:26:20 INFO - PROCESS | 8914 | Cycle 1(1): loaded http://localhost:36562/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36562/tests/kraken/driver.html?testName=imaging-desaturate) 02:26:20 INFO - PROCESS | 8914 | RSS: Main: 213823488 02:26:20 INFO - PROCESS | 8914 | 02:26:23 INFO - PROCESS | 8914 | Cycle 1(1): loaded http://localhost:36562/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36562/tests/kraken/driver.html?testName=json-parse-financial) 02:26:24 INFO - PROCESS | 8914 | RSS: Main: 213942272 02:26:24 INFO - PROCESS | 8914 | 02:26:25 INFO - PROCESS | 8914 | Cycle 1(1): loaded http://localhost:36562/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36562/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:26:26 INFO - PROCESS | 8914 | RSS: Main: 203816960 02:26:26 INFO - PROCESS | 8914 | 02:26:28 INFO - PROCESS | 8914 | Cycle 1(1): loaded http://localhost:36562/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36562/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:26:28 INFO - PROCESS | 8914 | RSS: Main: 205185024 02:26:28 INFO - PROCESS | 8914 | 02:26:30 INFO - PROCESS | 8914 | Cycle 1(1): loaded http://localhost:36562/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36562/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:26:31 INFO - PROCESS | 8914 | RSS: Main: 218292224 02:26:31 INFO - PROCESS | 8914 | 02:26:33 INFO - PROCESS | 8914 | Cycle 1(1): loaded http://localhost:36562/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36562/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:26:34 INFO - PROCESS | 8914 | RSS: Main: 224169984 02:26:34 INFO - PROCESS | 8914 | 02:26:37 INFO - PROCESS | 8914 | Cycle 1(1): loaded http://localhost:36562/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36562/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:26:37 INFO - PROCESS | 8914 | RSS: Main: 218877952 02:26:37 INFO - PROCESS | 8914 | 02:26:39 INFO - PROCESS | 8914 | Cycle 1(1): loaded http://localhost:36562/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36562/tests/kraken/driver.html?testName=ai-astar) 02:26:39 INFO - PROCESS | 8914 | RSS: Main: 282787840 02:26:39 INFO - PROCESS | 8914 | 02:26:39 INFO - PROCESS | 8914 | __start_tp_report 02:26:39 INFO - PROCESS | 8914 | _x_x_mozilla_page_load 02:26:39 INFO - PROCESS | 8914 | _x_x_mozilla_page_load_details 02:26:39 INFO - PROCESS | 8914 | |i|pagename|runs| 02:26:39 INFO - PROCESS | 8914 | |0;ai-astar;109;111;108;112;110;110;101;110;110;110 02:26:39 INFO - PROCESS | 8914 | |1;audio-beat-detection;158;127;155;180;128;157;155;128;203;127 02:26:39 INFO - PROCESS | 8914 | |2;audio-dft;162;161;161;162;163;161;162;162;163;162 02:26:39 INFO - PROCESS | 8914 | |3;audio-fft;76;75;103;116;77;73;73;112;105;77 02:26:39 INFO - PROCESS | 8914 | |4;audio-oscillator;92;94;144;93;91;94;150;93;92;162 02:26:39 INFO - PROCESS | 8914 | |5;imaging-gaussian-blur;117;117;116;116;117;117;117;116;117;117 02:26:39 INFO - PROCESS | 8914 | |6;imaging-darkroom;145;145;146;145;145;145;145;146;146;145 02:26:39 INFO - PROCESS | 8914 | |7;imaging-desaturate;95;95;95;95;95;95;95;94;94;94 02:26:39 INFO - PROCESS | 8914 | |8;json-parse-financial;55;56;56;56;56;57;57;72;54;53 02:26:39 INFO - PROCESS | 8914 | |9;json-stringify-tinderbox;61;62;62;61;62;62;62;63;63;62 02:26:39 INFO - PROCESS | 8914 | |10;stanford-crypto-aes;76;77;75;83;76;77;76;78;78;77 02:26:39 INFO - PROCESS | 8914 | |11;stanford-crypto-ccm;128;130;132;124;123;123;122;122;154;129 02:26:39 INFO - PROCESS | 8914 | |12;stanford-crypto-pbkdf2;166;164;168;164;169;170;167;163;171;172 02:26:39 INFO - PROCESS | 8914 | |13;stanford-crypto-sha256-iterative;69;70;69;69;69;70;70;68;67;70 02:26:39 INFO - PROCESS | 8914 | __end_tp_report 02:26:39 INFO - PROCESS | 8914 | __start_cc_report 02:26:39 INFO - PROCESS | 8914 | _x_x_mozilla_cycle_collect,1626 02:26:39 INFO - PROCESS | 8914 | __end_cc_report 02:26:39 INFO - PROCESS | 8914 | __startTimestamp1461057999913__endTimestamp 02:26:39 INFO - PROCESS | 8914 | 02:26:39 INFO - PROCESS | 8914 | ------- Summary: start ------- 02:26:39 INFO - PROCESS | 8914 | Number of tests: 14 02:26:39 INFO - PROCESS | 8914 | 02:26:39 INFO - PROCESS | 8914 | [#0] ai-astar Cycles:10 Average:109.10 Median:110.00 stddev:3.03 (2.8%) stddev-sans-first:3.22 02:26:39 INFO - PROCESS | 8914 | Values: 109.0 111.0 108.0 112.0 110.0 110.0 101.0 110.0 110.0 110.0 02:26:39 INFO - PROCESS | 8914 | 02:26:39 INFO - PROCESS | 8914 | [#1] audio-beat-detection Cycles:10 Average:151.80 Median:156.00 stddev:25.53 (16.4%) stddev-sans-first:26.98 02:26:39 INFO - PROCESS | 8914 | Values: 158.0 127.0 155.0 180.0 128.0 157.0 155.0 128.0 203.0 127.0 02:26:39 INFO - PROCESS | 8914 | 02:26:39 INFO - PROCESS | 8914 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 02:26:39 INFO - PROCESS | 8914 | Values: 162.0 161.0 161.0 162.0 163.0 161.0 162.0 162.0 163.0 162.0 02:26:39 INFO - PROCESS | 8914 | 02:26:39 INFO - PROCESS | 8914 | [#3] audio-fft Cycles:10 Average:88.70 Median:74.00 stddev:17.87 (24.1%) stddev-sans-first:18.35 02:26:39 INFO - PROCESS | 8914 | Values: 76.0 75.0 103.0 116.0 77.0 73.0 73.0 112.0 105.0 77.0 02:26:39 INFO - PROCESS | 8914 | 02:26:39 INFO - PROCESS | 8914 | [#4] audio-oscillator Cycles:10 Average:110.50 Median:92.50 stddev:28.98 (31.3%) stddev-sans-first:29.95 02:26:39 INFO - PROCESS | 8914 | Values: 92.0 94.0 144.0 93.0 91.0 94.0 150.0 93.0 92.0 162.0 02:26:39 INFO - PROCESS | 8914 | 02:26:39 INFO - PROCESS | 8914 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 02:26:39 INFO - PROCESS | 8914 | Values: 117.0 117.0 116.0 116.0 117.0 117.0 117.0 116.0 117.0 117.0 02:26:39 INFO - PROCESS | 8914 | 02:26:39 INFO - PROCESS | 8914 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 02:26:39 INFO - PROCESS | 8914 | Values: 145.0 145.0 146.0 145.0 145.0 145.0 145.0 146.0 146.0 145.0 02:26:39 INFO - PROCESS | 8914 | 02:26:39 INFO - PROCESS | 8914 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 02:26:39 INFO - PROCESS | 8914 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 94.0 94.0 02:26:39 INFO - PROCESS | 8914 | 02:26:39 INFO - PROCESS | 8914 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:56.00 stddev:5.35 (9.6%) stddev-sans-first:5.61 02:26:39 INFO - PROCESS | 8914 | Values: 55.0 56.0 56.0 56.0 56.0 57.0 57.0 72.0 54.0 53.0 02:26:39 INFO - PROCESS | 8914 | 02:26:39 INFO - PROCESS | 8914 | [#9] json-stringify-tinderbox Cycles:10 Average:62.00 Median:62.00 stddev:0.67 (1.1%) stddev-sans-first:0.60 02:26:39 INFO - PROCESS | 8914 | Values: 61.0 62.0 62.0 61.0 62.0 62.0 62.0 63.0 63.0 62.0 02:26:39 INFO - PROCESS | 8914 | 02:26:39 INFO - PROCESS | 8914 | [#10] stanford-crypto-aes Cycles:10 Average:77.30 Median:77.00 stddev:2.21 (2.9%) stddev-sans-first:2.30 02:26:39 INFO - PROCESS | 8914 | Values: 76.0 77.0 75.0 83.0 76.0 77.0 76.0 78.0 78.0 77.0 02:26:39 INFO - PROCESS | 8914 | 02:26:39 INFO - PROCESS | 8914 | [#11] stanford-crypto-ccm Cycles:10 Average:128.70 Median:128.50 stddev:9.60 (7.5%) stddev-sans-first:10.18 02:26:39 INFO - PROCESS | 8914 | Values: 128.0 130.0 132.0 124.0 123.0 123.0 122.0 122.0 154.0 129.0 02:26:39 INFO - PROCESS | 8914 | 02:26:39 INFO - PROCESS | 8914 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.40 Median:168.50 stddev:3.13 (1.9%) stddev-sans-first:3.28 02:26:39 INFO - PROCESS | 8914 | Values: 166.0 164.0 168.0 164.0 169.0 170.0 167.0 163.0 171.0 172.0 02:26:39 INFO - PROCESS | 8914 | 02:26:39 INFO - PROCESS | 8914 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.50 stddev:0.99 (1.4%) stddev-sans-first:1.05 02:26:39 INFO - PROCESS | 8914 | Values: 69.0 70.0 69.0 69.0 69.0 70.0 70.0 68.0 67.0 70.0 02:26:39 INFO - PROCESS | 8914 | -------- Summary: end -------- 02:26:39 INFO - PROCESS | 8914 | 02:26:40 INFO - TEST-INFO | 8914: exit 0 02:26:40 INFO - TEST-OK | kraken | took 60900ms 02:26:40 INFO - SUITE-END | took 1172s 02:26:41 INFO - Completed test suite (00:19:33) 02:26:41 INFO - javascript benchmark 02:26:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3012.4426981008514, 3033.3326668133004, 3066.8926587569426, 3075.5079187330016, 3105.021918095799, 5048.697078175312, 5153.149730294506, 5171.508706672865, 5177.585793136544, 5218.8695282617955, 5228.372595288562, 5232.2674825524455, 5249.527542521172, 5331.280277162582, 5336.67979921204, 4677.204875171212, 4752.667313288071, 4806.543378379049, 4867.221244600864, 4874.000829829876, 4804.423469183703, 4816.903661926759, 4819.903601927959, 4867.221244600864, 4917.4836642152595, 4643.512431194727, 4749.358836557055, 4813.518648135194, 4820.132376172288, 4839.249916262985, 4796.808127674889, 4797.832075877328, 4801.855944321676, 4820.903581928342, 4832.444268909086, 4660.1145782301255, 4745.833895813665, 4764.547368000034, 4775.092732380836, 4841.104395686809, 5030.0694371541385, 5031.823886163967, 5037.974810125963, 5057.216131499624, 5063.038022775698, 5416.160495123262, 5428.321459817523, 5547.5007249347345, 5639.577031722637, 5659.009673307155, 5638.971805140989, 5642.294713160855, 5646.2942132233475, 5646.40712725162, 5694.886102277931, 5245.973770131125, 5263.736813159365, 5266.210068489719, 5266.236395722637, 5268.446813084571, 5474.151506516497, 5686.545076393962, 5738.024535828919, 5751.194832723422, 5798.5651076168615, 5438.945610543844, 5445.891082178334, 5477.233187353773, 5491.972540137273, 5504.834854954358, 5552.0, 5552.250446189793, 5568.192612071227, 5570.303712035996, 5571.66570005801, 5302.655327403706, 5504.972475137679, 5580.693061881554, 5631.267935168402, 5670.234518339971, 5589.273394458775, 5603.439656034446, 5610.775568977277, 5611.691356975324, 5616.887662246814, 4088.182363527247, 4245.957540424618, 4251.341042138473, 4252.128313695685, 4297.312430011246, 3749.1189570450924, 3777.036855601804, 3790.469334293201, 3831.750936189139, 3838.5393752749846, 5307.52232299095, 5341.732913354317, 5342.1185504392115, 5346.97326513365, 5348.1175606025345, 5444.972775136099, 5613.242212301368, 5619.466150715675, 5625.578081643893, 5670.319561652628, 5326.121190003683, 5350.8662283442445, 5352.384475785335, 5361.356637203483, 5403.9459605403445, 4823.614110871122, 4824.252240902595, 4825.806967721252, 4840.733759643183, 4864.73243971585, 5533.861653458695, 5706.657600543981, 5797.072468405035, 5802.042662960649, 5809.622374545641, 5636.802711905064, 5645.0, 5646.435356464321, 5668.234788303609, 5673.432656734459, 5798.362180160263, 5803.7968671096305, 5810.564207684525, 5811.389804070512, 5815.709214539172, 5282.867928301823, 5464.91802622953, 5524.613277070566, 5530.640508366943, 5555.30558680165, 5548.750306236148, 5556.083246264321, 5558.888822223452, 5559.388467268678, 5586.776528938797, 5400.9459905400445, 5408.432114627907, 5413.998410294108, 5421.512063914267, 5445.754941027584, 5248.947510524846, 5404.378496472956, 5423.050966080999, 5498.80754173602, 5516.503514683698, 5371.355437347387, 5375.650582712111, 5408.810691625774, 5427.782888684408, 5429.077056900257, 5499.1476321170285, 5513.365962914156, 5525.171224316385, 5543.8891222174525, 5595.608307418442, 5159.947414548557, 5229.346331708536, 5348.973255133699, 5355.143177091647, 5420.53925416344], "value": 5151.791105660228, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [605.3734384911618, 652.2303681655648, 653.9210303000052, 654.5745265577376, 660.7621256347715, 27828.165155045357, 36155.81922090389, 37110.0, 37183.62816371836, 37225.99999999996, 39908.0, 40422.0, 40453.797731011306, 40570.18859622806, 40609.0, 8505.74482765518, 8723.25852302555, 8724.956375218115, 8727.95636021819, 8732.08313127122, 8666.86999695002, 8761.430507017023, 8779.473231606124, 8793.340499462534, 8798.164174403422, 8833.469991800512, 8905.910940890606, 8909.777255568597, 8917.063708310632, 8919.331050171264, 8773.210411063003, 8814.735557933273, 8831.514266715329, 8837.867431988494, 8842.292616590657, 8656.913430865736, 8721.171488708562, 8776.912230877737, 8788.0, 8791.692290769857, 39367.40948885769, 39764.60235397638, 39792.20415591701, 39896.0, 39903.201935961115, 3416.982915085409, 3439.9312013759836, 3641.635836416364, 3772.962270377316, 4103.220388126277, 30827.845860770776, 30922.381552368828, 31128.0, 31536.842315788275, 32388.67611323904, 4034.3545032794614, 4115.650169735576, 4127.5666055064385, 4228.92162498564, 4334.306510958263, 289849.9999999979, 293018.0, 293189.0, 294192.0, 295519.0, 53989.73005134949, 54274.0, 54356.45643543593, 54673.45326546763, 54784.0, 59394.40605593889, 59562.70218648966, 59674.40325596775, 59714.402855971755, 59790.70104649536, 14384.85615143856, 14499.565013049625, 14583.85416145825, 14597.343119559646, 14604.05073670208, 10060.748481288027, 10066.09405153525, 10088.949555252177, 10091.798164036678, 10104.393736375841, 15388.769168462482, 16719.414820481226, 16776.328946842234, 16813.327466901188, 16831.831681683027, 4918.794430761719, 5795.710214489259, 5818.912716309259, 5880.971064982574, 5991.310999235056, 1043.7683533430472, 1105.40308233553, 1131.9264247823864, 1138.248755821154, 1178.8231765235284, 27834.222208980143, 28082.157535273975, 28510.86168537368, 29917.0, 29997.400051998837, 1122.6014764758393, 1150.1546363422879, 1160.9593664221711, 1180.9704757381135, 1185.25921299188, 15618.45335413255, 16022.839771602135, 16049.197540122947, 16135.047013191555, 16172.94631226189, 398250.0, 407646.0, 409697.0, 410344.0, 413061.0, 56093.7195314029, 56314.71842640843, 56470.717646411504, 56772.432275676714, 56776.43223567794, 745.1238220468986, 1189.3220864107375, 1218.06817784395, 1291.7481091187128, 1422.964425889361, 29706.0, 31388.0, 31464.37071258516, 31512.2121946944, 32005.6799432012, 44245.55754442414, 44769.328460073775, 44819.0, 44845.32732008957, 44867.65397038094, 277747.0, 279291.0, 280012.0, 280065.0, 280437.0, 26369.472610548066, 27791.16626501208, 27809.860950695118, 27855.721442785314, 27894.721052789213, 44596.77701611471, 45096.0, 45425.318620221384, 45468.545314546434, 45521.089578208914, 39313.0, 39757.20485590214, 39833.80083099566, 40137.59862401456, 40142.598574013886, 38188.0, 38932.80533597427, 39550.40674389829, 39625.40561891516, 39696.0, 40052.39921401123, 40277.597224027384, 41500.37749433701, 42913.0, 42928.57071429371, 30315.696843031288, 31954.36091278115, 32465.0, 32780.50829237611, 32864.1783955403, 25145.805629018712, 26895.193144205707, 27454.588181177696, 27462.450750985266, 27562.724372756016], "value": 18623.909663056304, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.3745975491052, 392.2879972849278, 394.57780175212537, 396.6430212808472, 405.3534612293392, 16711.0, 17641.91179044103, 18401.263949442007, 18590.62818743626, 18604.0, 16772.66454670906, 17258.0, 17602.823971760277, 17846.910765446155, 17886.64226715465, 5507.228987941681, 5641.435856414367, 5659.943400566003, 5669.971650141743, 5672.205891175238, 3833.3674943634405, 5843.094320380348, 6181.598196117238, 6181.660008699542, 6188.876222475547, 5918.940810591882, 6112.052631842072, 6124.938750612481, 6133.723982420802, 6166.6916654167335, 3907.1013666856497, 6027.849303767441, 6053.878922421571, 6105.969470152643, 6109.144719739218, 5131.486851314876, 5456.48163424474, 5465.945340546623, 5472.480114389126, 5474.863128421821, 20272.391828245178, 20423.591528169352, 21866.453338666503, 22124.668129978065, 22168.0, 2286.2341115726254, 2333.56828986638, 2429.8906549205153, 2435.926922192337, 2464.1621848571394, 9066.5920033598, 13946.723974211645, 14199.0, 14514.637134071627, 14546.92726536371, 1906.8665193436466, 1915.9042047897549, 1931.6040211756556, 1955.285037991813, 2066.700328452381, 76750.0, 79706.0, 81362.59318703428, 81933.0, 82653.0, 10516.789664206826, 10610.151187904949, 10794.352338859693, 11115.388653624128, 11296.37869917146, 15047.473338433103, 15157.242137893281, 15161.317740701696, 15192.772108418383, 15198.46805361807, 7416.592087435243, 7540.283673051052, 7618.123915749649, 7687.961560192163, 7755.92244077552, 7073.257307982588, 7122.71509139639, 7142.964285178645, 7264.600446975467, 7295.927040729631, 4120.49601895306, 4405.867823965286, 4482.932756008662, 4536.160810250049, 4658.836940707059, 1809.511431913376, 1871.5695390060362, 1876.3245231716571, 1882.6328865871023, 1942.796006419334, 910.7996240827008, 997.645835728306, 1013.7871047080048, 1042.3849928542197, 1052.2371280821496, 17526.123693815258, 17755.46733597994, 17774.91112544429, 18087.638247234983, 18384.724229136573, 974.541965276319, 992.5136683025265, 1035.7669524357111, 1043.4782608695652, 1047.7223535763028, 9743.220542356594, 9921.454320012468, 10001.099901008944, 10013.39919604826, 10033.648822291185, 448448.0, 456792.0, 470237.0, 474746.0, 476349.0, 87964.0, 90731.0, 91060.0, 91389.54305228431, 91496.08503914876, 1096.2162054131175, 1106.336198281025, 1116.815725405299, 1117.8155604325195, 1119.3787447966295, 15715.764263535828, 15974.121423321363, 15986.920065399598, 16058.598535036717, 16138.112403817902, 34521.30957380788, 34836.0, 35229.82385088058, 35805.0, 35965.0, 51877.7406112967, 52985.0, 53010.46989530055, 53672.19491707705, 53991.0, 8035.83928321442, 8227.0, 8379.832403351777, 8500.44747091437, 8667.696630617898, 7281.927180728125, 12322.383880806103, 12356.0, 12542.12205145631, 13245.668858278621, 10954.890451095387, 10992.0, 10993.230473866752, 11342.886571134182, 11362.204645674723, 10934.61211848731, 11059.668209953392, 11063.391513466837, 11350.772984540428, 11398.658040258806, 11004.22970392097, 11010.50452729645, 11430.885691142983, 11703.531858725897, 11785.941070294593, 8167.305779008851, 8215.58922053883, 8265.504069755834, 8419.368547359096, 8429.831403372022, 10348.379097254188, 11241.55033798639, 11426.542938282375, 11635.709107272385, 11797.29216247028], "value": 8958.215045488774, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1329.0962145740893, 1527.4653871145101, 1546.0028281758266, 1738.4697667211503, 1864.6643604151263, 8105.91894081059, 8443.282321002715, 8445.366597505197, 8456.915430845698, 8467.788305292372, 8252.752417427471, 8408.327333813295, 8415.410921235516, 8428.0, 8437.114103019172, 2005.4886004068942, 2286.314105768267, 2287.942801429961, 2311.884405779713, 2370.2533701883935, 2317.5944209763306, 2338.6608941703444, 2339.4385347516645, 2339.6256598944174, 2340.5318936212825, 2252.4706693926914, 2267.4218074391006, 2289.305913623923, 2296.0700916128912, 2297.0, 1970.5467742419253, 2255.86464812111, 2337.146941366406, 2337.1586228957563, 2340.0873659272897, 2278.532900755358, 2292.4956509568037, 2293.1515339324555, 2305.4927915858652, 2319.373769082338, 8311.709090181876, 8397.70608028716, 8424.578771061484, 8429.199226073575, 8436.156384361577, 5027.145385284511, 5173.198154286091, 5175.146100893348, 5187.170052791573, 5261.552768014723, 3164.17731389838, 3189.61724593048, 3222.274988127676, 3235.0780027691994, 3282.556854824616, 1046.4453839465095, 1051.3481641382316, 1085.8914108589156, 1102.7077824376547, 1104.1498046504228, 11989.820152697717, 11991.700207494796, 11999.460024298927, 12001.639950801577, 12009.279443233434, 4410.845620403271, 4416.403785488982, 4589.2657174851865, 4593.839215627504, 4612.169809434334, 10120.190384769201, 10122.493875306205, 10126.949365253127, 10130.797384052277, 10138.290319677551, 4475.843345482893, 5166.121759300928, 5170.71561064145, 5174.197999310113, 5178.482151784867, 4492.460904691393, 4555.886102847456, 4578.267477203632, 4597.471290801601, 4600.240960241589, 3887.9611203888167, 3956.0, 3966.0679740261016, 3974.324364857981, 3995.900102497461, 1269.0735762892955, 1270.84749830021, 1273.6752128207247, 1284.3578210894552, 1293.043148070421, 953.2993249961273, 960.3037797596826, 969.7817990951979, 989.6585677941099, 1003.4330603209163, 5788.247527821441, 5808.273965754281, 5851.444112809277, 5938.762449502058, 5972.313183983897, 1010.6715317521835, 1017.5471914997903, 1017.5980487707315, 1031.3502493429091, 1044.8484969679505, 3982.6017398260524, 4076.3681629347498, 4076.5515793262716, 4089.2026054919006, 4100.220958017967, 10133.695989120191, 10616.575336986589, 10639.361638301727, 10650.467476626138, 10685.679429617125, 10610.628627997983, 10708.303960242714, 10713.0, 10846.29499082557, 10897.455127243606, 7569.545827250383, 7969.641366138538, 7975.122736498981, 8006.759797206093, 8024.638891249791, 5718.1130227025815, 5890.823275301748, 5898.0, 6036.788712395045, 6075.665838378754, 9534.23726101924, 9594.088561586637, 9687.70936871895, 9698.660546881107, 9724.951375243361, 9583.616655333708, 9806.705798826046, 10067.194624430174, 10170.93205213442, 10236.283460157718, 6735.730570777114, 6955.1653801544135, 7116.750913717995, 7204.351608355064, 7478.887816682863, 7913.643886025257, 7954.681812727426, 7969.043714754266, 7996.56018918965, 8000.0, 6707.5304728668525, 6824.146981627297, 6862.005009273727, 7007.6145811978795, 7072.045273887959, 6871.690773915286, 6883.586984780729, 6943.722251109899, 6958.443324533924, 6995.685194166173, 6671.733130674718, 6699.263081060982, 6725.831854203684, 6732.730690772511, 6771.153605799275, 5010.121204548294, 5041.798328066836, 5093.567046801063, 5154.819581314636, 5187.870303242449, 4977.60179185657, 5051.191809310492, 5116.820911268088, 5136.0, 5184.274201611853], "value": 4520.698592213892, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.65422171166, 323.86235849763847, 331.8357413080525, 333.73801565770844, 335.7666421836823, 5556.583256255777, 5595.608307418483, 5603.887922241553, 5645.125005624124, 5670.177824215497, 5591.133374326976, 5603.271574695284, 5603.861837371075, 5609.3268807743125, 5622.578306627009, 4104.15864747726, 4157.584241575833, 4327.870163895088, 4360.324149756792, 4368.628666563346, 4314.719543229696, 4332.292317301686, 4342.131573685259, 4349.782510874444, 4362.607365337119, 4141.792910354486, 4296.57034296571, 4299.978500107511, 4311.892202694942, 4313.439252897119, 4143.689223308249, 4298.226319262531, 4312.547182545819, 4327.307630779061, 4333.241682705546, 3763.0, 3771.4531392948143, 3785.6971442284826, 3786.5266841644793, 3789.1853251550774, 5309.65487243328, 5418.133098704188, 5425.046983086086, 5439.80324328647, 5449.182622606601, 4921.901561968776, 4956.157453232923, 4976.303317535548, 4983.875403114951, 4992.800287988476, 5778.913316300217, 5814.156947242626, 5815.79644712433, 5837.620554663933, 5847.122931560258, 4000.6799456043445, 4149.668026557868, 4162.937555936664, 4166.749995000279, 4170.249355116078, 6095.542834287447, 6098.878022439526, 6106.450419462225, 6115.510759139258, 6146.108814221912, 4215.957840421618, 4250.341197114452, 4265.997490589709, 4267.850625228102, 4274.551172126882, 4226.429432026637, 4325.5674432557125, 4327.112941846914, 4335.609795118455, 4354.455693038371, 4937.086638971802, 4946.1344264753525, 4952.306677065214, 4955.0, 4962.032403681247, 5864.794732184353, 5884.735186916599, 5897.380775018647, 5911.379305172981, 5916.349201587822, 1474.837767845536, 1490.4857824050684, 1506.8041154650045, 1514.4169494744604, 1518.468536012409, 936.7096200177966, 1006.6476733143342, 1015.6496008876926, 1024.7335692719946, 1036.5957276662107, 5598.4961353477565, 5600.52395546375, 5678.744456499468, 5686.402927692616, 5701.771929122789, 5943.197668314809, 5963.671998040063, 5995.910061349084, 5996.400359963969, 6033.698315084316, 5561.555075593943, 5673.404292549306, 5766.336871259775, 5778.422157784188, 5790.94209057904, 3186.4901615741833, 3259.7718159729066, 3268.7251971731043, 3284.178955261185, 3291.8683252669625, 6133.938660613426, 6309.0, 6322.778702745474, 6399.104125422445, 6414.550981431255, 6136.018237082135, 6181.505479561624, 6207.0, 6232.937670623326, 6268.028455589391, 6127.20346354971, 6316.463100636405, 6320.55756097078, 6321.747130114744, 6333.429991300805, 6083.756649733961, 6129.141920131275, 6132.2947860996555, 6137.723802428812, 6141.201643786458, 6056.788012419544, 6057.454829065406, 6059.454649081604, 6079.969600151971, 6080.604760690541, 6105.633661980295, 6280.142535146589, 6309.1734822859635, 6310.0, 6358.237011558643, 4260.211860805637, 4273.316269396882, 4280.636145927631, 4282.0793529390085, 4291.549387314287, 5893.543696089502, 6065.605735627347, 6071.089336599545, 6073.240844894388, 6104.816855494342, 5827.358990511125, 5849.970750146222, 5855.824325270249, 5891.116332550152, 5903.852403689771, 5887.675273063698, 5892.234009578728, 5909.674967876808, 5921.467067963904, 5925.0, 5683.8010669626365, 5793.768249269982, 5803.158542011469, 5849.181114644039, 5864.120381942743, 5953.791617293374, 5975.0, 6001.309849367379, 6004.849878753066, 6010.106816352835, 5634.605577609692, 5836.474717275466, 5840.795572154954, 5865.970670146793, 5875.294964604275], "value": 4479.0028240628735, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [800.6717245929169, 855.2302927365374, 868.3574155125209, 873.7247766953409, 874.3966663002528, 13516.526921557748, 13817.51638692646, 13836.377363018662, 16311.429099981504, 16556.254968526417, 15425.0, 15501.689966200669, 15550.0, 15558.844411555881, 15583.454579089734, 653.3140202787079, 817.697451942782, 840.3445312656138, 847.0936098374741, 847.9576021198947, 830.887830142929, 834.5493433545878, 837.1335667584052, 837.7403005068418, 838.6226198210829, 864.6973559254242, 871.877937088808, 875.4703404440286, 875.7241468937297, 876.8903887014123, 679.3478260869571, 701.2426579294375, 702.4801646781345, 841.5455653946862, 867.6616119713285, 629.1192330736959, 631.1700114349616, 632.5477283742147, 633.8985762278013, 635.841039740065, 14685.632859178499, 14731.852681473156, 14749.188794616291, 14764.26178691061, 14785.556433307018, 13272.668183295495, 13513.325516227167, 13641.795373069412, 13661.658458538517, 13720.245386503739, 11632.0, 11749.88250117505, 12086.818697719542, 12227.877721222763, 12258.20321679097, 3883.650471457582, 3923.3330333843314, 3944.684425245973, 3959.0696186396176, 4023.2556976959063, 56456.0, 59296.0, 59848.0, 60686.39313606852, 61340.38659613436, 10812.567497300177, 10833.133349332034, 10872.78254434907, 11007.724806879893, 11131.443427828739, 19709.507262318555, 19740.11169497376, 19784.406467805988, 19806.405807825788, 20395.184192632427, 8234.958825205955, 8275.793105172419, 8331.458455200393, 8356.0, 8442.113578074337, 4591.357209990604, 4720.126776546282, 4724.4094488188975, 4760.809567617326, 4798.66409351349, 3330.6169790473923, 3427.503012063287, 3428.5542879425516, 3428.674275943781, 3431.227973705896, 634.8254230086764, 658.9736410543525, 670.5373292428209, 674.8414122681166, 676.6143298319911, 711.2922641971272, 718.9568625882464, 735.5696917303437, 748.5508694783196, 749.8987636668979, 9057.292081971145, 9319.720408387759, 9372.67195648149, 9489.857652135224, 9712.368696034735, 712.6472396163829, 713.2902761751986, 720.4632548751109, 728.1953441447231, 729.5221629832469, 4260.510041345285, 4286.807093680792, 4363.498197707241, 4472.217361961643, 4557.339185818038, 61172.38827611756, 61465.38534614686, 62088.379116209166, 62616.425275345435, 64455.35544644587, 52769.472305277224, 53685.46314536883, 54761.0, 55174.44825551693, 55486.0, 48884.0, 49584.0, 49975.0, 50555.49444505582, 52346.999999999236, 8873.600687968928, 9109.544522773702, 9121.270298375981, 9121.635134594542, 9128.0, 32825.83587082145, 33424.33151336911, 33817.49273760945, 33987.3202535943, 34222.828885856405, 42375.0, 46364.0, 46566.0, 47312.52687473219, 47528.52471475241, 12123.151379403356, 12208.511659533875, 12244.265344079384, 12308.815367769312, 12385.442655080362, 12594.748105038032, 12835.743285134431, 13101.541446049343, 13648.317584120952, 13719.862801371859, 10867.836982445111, 12177.452014659539, 12493.312867792358, 13205.405756740778, 13637.0, 11899.345535995604, 12034.037277017642, 12106.697332566757, 12132.0, 12178.512859485876, 12614.747705046031, 12815.295158766357, 12917.547885824328, 12958.935205323913, 13058.477660893457, 9644.01165343019, 10068.29521933487, 10117.392956422638, 10199.0820826126, 10400.167986561208, 11585.942070289595, 11598.826017609912, 11643.417829108681, 11658.10035948759, 11862.110341724232], "value": 6841.422517248601, "unit": "score"}], "name": "dromaeo_css", "value": 7014.081856499228, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 111.0, 108.0, 112.0, 110.0, 110.0, 101.0, 110.0, 110.0, 110.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 127.0, 155.0, 180.0, 128.0, 157.0, 155.0, 128.0, 203.0, 127.0], "value": 151.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 162.0, 163.0, 161.0, 162.0, 162.0, 163.0, 162.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 103.0, 116.0, 77.0, 73.0, 73.0, 112.0, 105.0, 77.0], "value": 88.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 144.0, 93.0, 91.0, 94.0, 150.0, 93.0, 92.0, 162.0], "value": 110.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 146.0, 146.0, 145.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 56.0, 56.0, 56.0, 57.0, 57.0, 72.0, 54.0, 53.0], "value": 57.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 61.0, 62.0, 62.0, 62.0, 63.0, 63.0, 62.0], "value": 62.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 75.0, 83.0, 76.0, 77.0, 76.0, 78.0, 78.0, 77.0], "value": 77.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 130.0, 132.0, 124.0, 123.0, 123.0, 122.0, 122.0, 154.0, 129.0], "value": 128.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 164.0, 168.0, 164.0, 169.0, 170.0, 167.0, 163.0, 171.0, 172.0], "value": 167.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 69.0, 69.0, 69.0, 70.0, 70.0, 68.0, 67.0, 70.0], "value": 69.1, "unit": "score"}], "name": "kraken", "value": 1540.4, "alertThreshold": 2.0}]} 02:26:41 INFO - Return code: 0 02:26:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:26:41 ERROR - # TBPL SUCCESS # 02:26:41 INFO - Running post-action listener: _resource_record_post_action 02:26:41 INFO - Running post-run listener: _resource_record_post_run 02:26:42 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 536211456; Read time: 12; Write time: 617040 02:26:42 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 244326400; Read time: 0; Write time: 335676 02:26:42 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291885056; Read time: 12; Write time: 281364 02:26:42 INFO - Running post-run listener: _upload_blobber_files 02:26:42 INFO - Blob upload gear active. 02:26:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:26:42 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 02:26:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:26:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:26:42 INFO - (blobuploader) - INFO - Open directory for files ... 02:26:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:26:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:26:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:26:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:26:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:26:43 INFO - (blobuploader) - INFO - Done attempting. 02:26:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:26:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:26:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:26:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:26:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:26:44 INFO - (blobuploader) - INFO - Done attempting. 02:26:44 INFO - (blobuploader) - INFO - Iteration through files over. 02:26:44 INFO - Return code: 0 02:26:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:26:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:26:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/66a337ddc446055555428021f4c5f8370f6207a6161130a122cd188ddbd31df7ab3b22269972d835c773d67801abc62dc1194a9eade4d117f31629d3f367bf5c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1e4cbae7b9f8a905ad9e191b3aad67e9151672efe88fa5252d0b22659966cb0388974fca103ade122b2c3a042fc4879d1a347c8de022c4451e1afefb314796fa"} 02:26:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:26:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:26:44 INFO - Contents: 02:26:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/66a337ddc446055555428021f4c5f8370f6207a6161130a122cd188ddbd31df7ab3b22269972d835c773d67801abc62dc1194a9eade4d117f31629d3f367bf5c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1e4cbae7b9f8a905ad9e191b3aad67e9151672efe88fa5252d0b22659966cb0388974fca103ade122b2c3a042fc4879d1a347c8de022c4451e1afefb314796fa"} 02:26:44 INFO - Running post-run listener: copy_logs_to_upload_dir 02:26:44 INFO - Copying logs to upload dir... 02:26:44 INFO - mkdir: /builds/slave/test/build/upload/logs 02:26:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.799004 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-04-19 02:26:43.908629) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-19 02:26:43.912487) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1461055996.254335-530092315 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/66a337ddc446055555428021f4c5f8370f6207a6161130a122cd188ddbd31df7ab3b22269972d835c773d67801abc62dc1194a9eade4d117f31629d3f367bf5c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1e4cbae7b9f8a905ad9e191b3aad67e9151672efe88fa5252d0b22659966cb0388974fca103ade122b2c3a042fc4879d1a347c8de022c4451e1afefb314796fa"} build_url:https://queue.taskcluster.net/v1/task/HNgas2hnQxasLDv-WckIjw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011394 build_url: 'https://queue.taskcluster.net/v1/task/HNgas2hnQxasLDv-WckIjw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/66a337ddc446055555428021f4c5f8370f6207a6161130a122cd188ddbd31df7ab3b22269972d835c773d67801abc62dc1194a9eade4d117f31629d3f367bf5c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1e4cbae7b9f8a905ad9e191b3aad67e9151672efe88fa5252d0b22659966cb0388974fca103ade122b2c3a042fc4879d1a347c8de022c4451e1afefb314796fa"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-19 02:26:43.936425) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 02:26:43.936708) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1461055996.254335-530092315 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004507 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 02:26:44.021715) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-19 02:26:44.022017) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-19 02:26:44.022304) ========= ========= Total master_lag: 0.17 =========