builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-021 starttime: 1461020773.61 results: success (0) buildid: 20160418142321 builduid: f60096c778d045cfae100ba6381db718 revision: dadd3d52a252edd85975ff73ac404325d28598b2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 16:06:13.608878) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 16:06:13.609512) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-18 16:06:13.610070) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-18 16:06:13.634301) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 16:06:13.634617) ========= 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=df17445c3590ff7897617a0e00000225-1461020462.471051-1730854258 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-18 16:06:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.1M=0s 2016-04-18 16:06:14 (43.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.114680 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 16:06:13.763190) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 16:06:13.763524) ========= 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=df17445c3590ff7897617a0e00000225-1461020462.471051-1730854258 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015397 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 16:06:13.815972) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 16:06:13.816540) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev dadd3d52a252edd85975ff73ac404325d28598b2 --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 dadd3d52a252edd85975ff73ac404325d28598b2 --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=df17445c3590ff7897617a0e00000225-1461020462.471051-1730854258 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-18 16:06:14,220 truncating revision to first 12 chars 2016-04-18 16:06:14,220 Setting DEBUG logging. 2016-04-18 16:06:14,220 attempt 1/10 2016-04-18 16:06:14,220 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/dadd3d52a252?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-18 16:06:14,510 unpacking tar archive at: fx-team-dadd3d52a252/testing/mozharness/ program finished with exit code 0 elapsedTime=0.584953 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 16:06:14.414999) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 16:06:14.415352) ========= script_repo_revision: dadd3d52a252edd85975ff73ac404325d28598b2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 16:06:14.415790) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 16:06:14.416120) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 16:06:14.424023) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-04-18 16:06:14.424346) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1461020462.471051-1730854258 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:06:14 INFO - MultiFileLogger online at 20160418 16:06:14 in /builds/slave/test 16:06:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 16:06:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:06:14 INFO - {'append_to_log': False, 16:06:14 INFO - 'base_work_dir': '/builds/slave/test', 16:06:14 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 16:06:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:06:14 INFO - 'branch': 'Fx-Team-Non-PGO', 16:06:14 INFO - 'buildbot_json_path': 'buildprops.json', 16:06:14 INFO - 'config_files': ('talos/linux_config.py',), 16:06:14 INFO - 'default_actions': ('clobber', 16:06:14 INFO - 'read-buildbot-config', 16:06:14 INFO - 'download-and-extract', 16:06:14 INFO - 'populate-webroot', 16:06:14 INFO - 'create-virtualenv', 16:06:14 INFO - 'install', 16:06:14 INFO - 'run-tests'), 16:06:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:06:14 INFO - 'download_minidump_stackwalk': True, 16:06:14 INFO - 'download_symbols': 'ondemand', 16:06:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:06:14 INFO - 'tooltool.py': '/tools/tooltool.py', 16:06:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:06:14 INFO - '/tools/misc-python/virtualenv.py')}, 16:06:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:06:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:06:14 INFO - 'installer_path': 'installer.exe', 16:06:14 INFO - 'log_level': 'info', 16:06:14 INFO - 'log_name': 'talos', 16:06:14 INFO - 'log_to_console': True, 16:06:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:06:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:06:14 INFO - 'opt_config_files': (), 16:06:14 INFO - 'pip_index': False, 16:06:14 INFO - 'sps_profile': False, 16:06:14 INFO - 'sps_profile_interval': 0, 16:06:14 INFO - 'suite': 'dromaeojs', 16:06:14 INFO - 'system_bits': '32', 16:06:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:06:14 INFO - 'title': 'talos-linux64-ix-021', 16:06:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:06:14 INFO - 'use_talos_json': True, 16:06:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:06:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:06:14 INFO - 'work_dir': 'build'} 16:06:14 INFO - ##### 16:06:14 INFO - ##### Running clobber step. 16:06:14 INFO - ##### 16:06:14 INFO - Running pre-action listener: _resource_record_pre_action 16:06:14 INFO - Running main action method: clobber 16:06:14 INFO - rmtree: /builds/slave/test/build 16:06:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:06:15 INFO - Running post-action listener: _resource_record_post_action 16:06:15 INFO - ##### 16:06:15 INFO - ##### Running read-buildbot-config step. 16:06:15 INFO - ##### 16:06:15 INFO - Running pre-action listener: _resource_record_pre_action 16:06:15 INFO - Running main action method: read_buildbot_config 16:06:15 INFO - Using buildbot properties: 16:06:15 INFO - { 16:06:15 INFO - "project": "", 16:06:15 INFO - "product": "firefox", 16:06:15 INFO - "script_repo_revision": "production", 16:06:15 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 16:06:15 INFO - "repository": "", 16:06:15 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 16:06:15 INFO - "buildid": "20160418142321", 16:06:15 INFO - "pgo_build": "False", 16:06:15 INFO - "basedir": "/builds/slave/test", 16:06:15 INFO - "buildnumber": 1656, 16:06:15 INFO - "slavename": "talos-linux64-ix-021", 16:06:15 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:06:15 INFO - "platform": "ubuntu64_hw", 16:06:15 INFO - "scheduler": "tests-fx-team-linux64-talos", 16:06:15 INFO - "branch": "fx-team", 16:06:15 INFO - "repo_path": "integration/fx-team", 16:06:15 INFO - "revision": "dadd3d52a252edd85975ff73ac404325d28598b2", 16:06:15 INFO - "stage_platform": "linux64", 16:06:15 INFO - "builduid": "f60096c778d045cfae100ba6381db718", 16:06:15 INFO - "slavebuilddir": "test" 16:06:15 INFO - } 16:06:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/cmUiJAjeQkqAWz0c_cpDTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 16:06:15 INFO - Running post-action listener: _resource_record_post_action 16:06:15 INFO - ##### 16:06:15 INFO - ##### Running download-and-extract step. 16:06:15 INFO - ##### 16:06:15 INFO - Running pre-action listener: _resource_record_pre_action 16:06:15 INFO - Running main action method: download_and_extract 16:06:15 INFO - mkdir: /builds/slave/test/build/tests 16:06:15 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')]} 16:06:15 INFO - https://queue.taskcluster.net/v1/task/cmUiJAjeQkqAWz0c_cpDTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:06:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmUiJAjeQkqAWz0c_cpDTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 16:06:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmUiJAjeQkqAWz0c_cpDTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 16:06:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmUiJAjeQkqAWz0c_cpDTA/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 16:06:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmUiJAjeQkqAWz0c_cpDTA/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 16:06:24 INFO - Downloaded 1361 bytes. 16:06:24 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 16:06:24 INFO - Using the following test package requirements: 16:06:24 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 16:06:24 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:06:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:06:24 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:06:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:06:24 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:06:24 INFO - u'jsshell-linux-x86_64.zip'], 16:06:24 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:06:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:06:24 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 16:06:24 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:06:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:06:24 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:06:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:06:24 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:06:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:06:24 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 16:06:24 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:06:24 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:06:24 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')]} 16:06:24 INFO - https://queue.taskcluster.net/v1/task/cmUiJAjeQkqAWz0c_cpDTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:06:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmUiJAjeQkqAWz0c_cpDTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:06:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmUiJAjeQkqAWz0c_cpDTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:06:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmUiJAjeQkqAWz0c_cpDTA/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 16:06:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmUiJAjeQkqAWz0c_cpDTA/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 16:06:31 INFO - Downloaded 22203755 bytes. 16:06:31 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'] 16:06:31 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 16:06:32 INFO - Return code: 0 16:06:32 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 16:06:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:06:32 INFO - https://queue.taskcluster.net/v1/task/cmUiJAjeQkqAWz0c_cpDTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:06:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmUiJAjeQkqAWz0c_cpDTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:06:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmUiJAjeQkqAWz0c_cpDTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 16:06:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmUiJAjeQkqAWz0c_cpDTA/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 16:06:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmUiJAjeQkqAWz0c_cpDTA/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 16:06:40 INFO - Downloaded 22203755 bytes. 16:06:40 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'] 16:06:40 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 16:06:41 INFO - Return code: 0 16:06:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:06:41 INFO - https://queue.taskcluster.net/v1/task/cmUiJAjeQkqAWz0c_cpDTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:06:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmUiJAjeQkqAWz0c_cpDTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 16:06:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmUiJAjeQkqAWz0c_cpDTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 16:06:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmUiJAjeQkqAWz0c_cpDTA/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 16:06:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmUiJAjeQkqAWz0c_cpDTA/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 16:06:43 INFO - Downloaded 10845952 bytes. 16:06:43 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'] 16:06:43 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 16:06:43 INFO - Return code: 0 16:06:43 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')]} 16:06:43 INFO - https://queue.taskcluster.net/v1/task/cmUiJAjeQkqAWz0c_cpDTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:06:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmUiJAjeQkqAWz0c_cpDTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:06:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmUiJAjeQkqAWz0c_cpDTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:06:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmUiJAjeQkqAWz0c_cpDTA/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 16:06:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cmUiJAjeQkqAWz0c_cpDTA/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 16:06:46 INFO - Downloaded 54452545 bytes. 16:06:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cmUiJAjeQkqAWz0c_cpDTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:06:46 INFO - mkdir: /builds/slave/test/properties 16:06:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:06:46 INFO - Writing to file /builds/slave/test/properties/build_url 16:06:46 INFO - Contents: 16:06:46 INFO - build_url:https://queue.taskcluster.net/v1/task/cmUiJAjeQkqAWz0c_cpDTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 16:06:47 INFO - Running post-action listener: _resource_record_post_action 16:06:47 INFO - Running post-action listener: set_extra_try_arguments 16:06:47 INFO - ##### 16:06:47 INFO - ##### Running populate-webroot step. 16:06:47 INFO - ##### 16:06:47 INFO - Running pre-action listener: _resource_record_pre_action 16:06:47 INFO - Running main action method: populate_webroot 16:06:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:06:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:06:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:06:47 INFO - '--tppagecycles', 16:06:47 INFO - '7'], 16:06:47 INFO - 'tests': ['tsvgm']}}, 16:06:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:06:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:06:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:06:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:06:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:06:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:06:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:06:47 INFO - 'talos_options': ['--disable-e10s'], 16:06:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:06:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:06:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:06:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:06:47 INFO - 'talos_options': ['--disable-e10s'], 16:06:47 INFO - 'tests': ['damp', 'tps']}, 16:06:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:06:47 INFO - 'tests': ['damp', 'tps']}, 16:06:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:06:47 INFO - 'tests': ['dromaeo_dom']}, 16:06:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:06:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:06:47 INFO - 'tests': ['a11yr', 16:06:47 INFO - 'ts_paint', 16:06:47 INFO - 'tpaint', 16:06:47 INFO - 'sessionrestore', 16:06:47 INFO - 'sessionrestore_no_auto_restore', 16:06:47 INFO - 'tabpaint']}, 16:06:47 INFO - 'other-e10s': {'tests': ['a11yr', 16:06:47 INFO - 'ts_paint', 16:06:47 INFO - 'tpaint', 16:06:47 INFO - 'sessionrestore', 16:06:47 INFO - 'sessionrestore_no_auto_restore', 16:06:47 INFO - 'tabpaint']}, 16:06:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:06:47 INFO - 'ts_paint', 16:06:47 INFO - 'tpaint', 16:06:47 INFO - 'sessionrestore', 16:06:47 INFO - 'sessionrestore_no_auto_restore', 16:06:47 INFO - 'tabpaint']}, 16:06:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:06:47 INFO - 'ts_paint', 16:06:47 INFO - 'tpaint', 16:06:47 INFO - 'sessionrestore', 16:06:47 INFO - 'sessionrestore_no_auto_restore', 16:06:47 INFO - 'tabpaint']}, 16:06:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:06:47 INFO - 'tests': ['a11yr', 16:06:47 INFO - 'ts_paint', 16:06:47 INFO - 'tpaint', 16:06:47 INFO - 'sessionrestore', 16:06:47 INFO - 'sessionrestore_no_auto_restore', 16:06:47 INFO - 'tabpaint']}, 16:06:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:06:47 INFO - 'tests': ['a11yr', 16:06:47 INFO - 'ts_paint', 16:06:47 INFO - 'tpaint', 16:06:47 INFO - 'sessionrestore', 16:06:47 INFO - 'sessionrestore_no_auto_restore', 16:06:47 INFO - 'tabpaint']}, 16:06:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:06:47 INFO - 'tests': ['tsvgx', 16:06:47 INFO - 'tsvgr_opacity', 16:06:47 INFO - 'tart', 16:06:47 INFO - 'tscrollx', 16:06:47 INFO - 'cart']}, 16:06:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:06:47 INFO - 'tsvgr_opacity', 16:06:47 INFO - 'tart', 16:06:47 INFO - 'tscrollx', 16:06:47 INFO - 'cart']}, 16:06:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:06:47 INFO - 'talos_options': ['--disable-e10s'], 16:06:47 INFO - 'tests': ['tp5o']}, 16:06:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:06:47 INFO - 'tests': ['tp5o']}, 16:06:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:06:47 INFO - 'talos_options': ['--disable-e10s', 16:06:47 INFO - '--xperf_path', 16:06:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:06:47 INFO - 'tests': ['tp5n']}, 16:06:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:06:47 INFO - 'talos_options': ['--xperf_path', 16:06:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:06:47 INFO - 'tests': ['tp5n']}}, 16:06:47 INFO - 'talos.zip': {'path': '', 16:06:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:06:47 INFO - Running post-action listener: _resource_record_post_action 16:06:47 INFO - ##### 16:06:47 INFO - ##### Running create-virtualenv step. 16:06:47 INFO - ##### 16:06:47 INFO - Running pre-action listener: _resource_record_pre_action 16:06:47 INFO - Running main action method: create_virtualenv 16:06:47 INFO - Creating virtualenv /builds/slave/test/build/venv 16:06:47 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 16:06:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:06:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:06:47 INFO - Using real prefix '/usr' 16:06:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:06:48 INFO - Installing distribute.............................................................................................................................................................................................done. 16:06:50 INFO - Installing pip.................done. 16:06:50 INFO - Return code: 0 16:06:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:06:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:06:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06:50 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 0x7fbe04c69f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c1c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cab410>, '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 0x1cac310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cac7a0>, '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': 'df17445c3590ff7897617a0e00000225-1461020462.471051-1730854258', '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 16:06:50 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 16:06:50 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 16:06:50 INFO - Using env: {'DISPLAY': ':0', 16:06:50 INFO - 'HOME': '/home/cltbld', 16:06:50 INFO - 'LANG': 'en_US.UTF-8', 16:06:50 INFO - 'LANGUAGE': 'en_US:en', 16:06:50 INFO - 'LOGNAME': 'cltbld', 16:06:50 INFO - 'MAIL': '/var/mail/cltbld', 16:06:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:50 INFO - 'MOZ_NO_REMOTE': '1', 16:06:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:06:50 INFO - 'NO_EM_RESTART': '1', 16:06:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:06:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:50 INFO - 'PWD': '/builds/slave/test', 16:06:50 INFO - 'SHELL': '/bin/bash', 16:06:50 INFO - 'SHLVL': '1', 16:06:50 INFO - 'TERM': 'linux', 16:06:50 INFO - 'TMOUT': '86400', 16:06:50 INFO - 'USER': 'cltbld', 16:06:50 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1461020462.471051-1730854258', 16:06:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:50 INFO - '_': '/tools/buildbot/bin/python'} 16:06:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:50 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 16:06:50 INFO - Cleaning up... 16:06:50 INFO - Return code: 0 16:06:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:06:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:06:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06:50 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 0x7fbe04c69f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c1c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cab410>, '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 0x1cac310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cac7a0>, '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': 'df17445c3590ff7897617a0e00000225-1461020462.471051-1730854258', '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 16:06:50 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 16:06:50 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 16:06:50 INFO - Using env: {'DISPLAY': ':0', 16:06:50 INFO - 'HOME': '/home/cltbld', 16:06:50 INFO - 'LANG': 'en_US.UTF-8', 16:06:50 INFO - 'LANGUAGE': 'en_US:en', 16:06:50 INFO - 'LOGNAME': 'cltbld', 16:06:50 INFO - 'MAIL': '/var/mail/cltbld', 16:06:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:50 INFO - 'MOZ_NO_REMOTE': '1', 16:06:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:06:50 INFO - 'NO_EM_RESTART': '1', 16:06:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:06:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:50 INFO - 'PWD': '/builds/slave/test', 16:06:50 INFO - 'SHELL': '/bin/bash', 16:06:50 INFO - 'SHLVL': '1', 16:06:50 INFO - 'TERM': 'linux', 16:06:50 INFO - 'TMOUT': '86400', 16:06:50 INFO - 'USER': 'cltbld', 16:06:50 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1461020462.471051-1730854258', 16:06:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:50 INFO - '_': '/tools/buildbot/bin/python'} 16:06:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:50 INFO - Downloading/unpacking psutil>=0.7.1 16:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:06:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:06:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:06:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:06:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:06:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:06:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:06:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:06:52 INFO - Installing collected packages: psutil 16:06:52 INFO - Running setup.py install for psutil 16:06:52 INFO - building 'psutil._psutil_linux' extension 16:06:52 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 16:06:52 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 16:06:53 INFO - building 'psutil._psutil_posix' extension 16:06:53 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 16:06:53 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 16:06:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:06:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:06:53 INFO - Successfully installed psutil 16:06:53 INFO - Cleaning up... 16:06:53 INFO - Return code: 0 16:06:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:06:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:06:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbe04c69f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c1c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cab410>, '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 0x1cac310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cac7a0>, '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': 'df17445c3590ff7897617a0e00000225-1461020462.471051-1730854258', '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 16:06:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 16:06:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 16:06:53 INFO - Using env: {'DISPLAY': ':0', 16:06:53 INFO - 'HOME': '/home/cltbld', 16:06:53 INFO - 'LANG': 'en_US.UTF-8', 16:06:53 INFO - 'LANGUAGE': 'en_US:en', 16:06:53 INFO - 'LOGNAME': 'cltbld', 16:06:53 INFO - 'MAIL': '/var/mail/cltbld', 16:06:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:53 INFO - 'MOZ_NO_REMOTE': '1', 16:06:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:06:53 INFO - 'NO_EM_RESTART': '1', 16:06:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:06:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:53 INFO - 'PWD': '/builds/slave/test', 16:06:53 INFO - 'SHELL': '/bin/bash', 16:06:53 INFO - 'SHLVL': '1', 16:06:53 INFO - 'TERM': 'linux', 16:06:53 INFO - 'TMOUT': '86400', 16:06:53 INFO - 'USER': 'cltbld', 16:06:53 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1461020462.471051-1730854258', 16:06:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:53 INFO - '_': '/tools/buildbot/bin/python'} 16:06:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:06:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:06:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:06:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:06:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:06:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:06:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:06:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:06:55 INFO - Installing collected packages: mozsystemmonitor 16:06:55 INFO - Running setup.py install for mozsystemmonitor 16:06:55 INFO - Successfully installed mozsystemmonitor 16:06:55 INFO - Cleaning up... 16:06:55 INFO - Return code: 0 16:06:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:06:55 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')]} 16:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06:55 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')]} 16:06:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06:55 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 0x7fbe04c69f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c1c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cab410>, '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 0x1cac310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cac7a0>, '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': 'df17445c3590ff7897617a0e00000225-1461020462.471051-1730854258', '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 16:06:55 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 16:06:55 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 16:06:55 INFO - Using env: {'DISPLAY': ':0', 16:06:55 INFO - 'HOME': '/home/cltbld', 16:06:55 INFO - 'LANG': 'en_US.UTF-8', 16:06:55 INFO - 'LANGUAGE': 'en_US:en', 16:06:55 INFO - 'LOGNAME': 'cltbld', 16:06:55 INFO - 'MAIL': '/var/mail/cltbld', 16:06:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:55 INFO - 'MOZ_NO_REMOTE': '1', 16:06:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:06:55 INFO - 'NO_EM_RESTART': '1', 16:06:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:06:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:55 INFO - 'PWD': '/builds/slave/test', 16:06:55 INFO - 'SHELL': '/bin/bash', 16:06:55 INFO - 'SHLVL': '1', 16:06:55 INFO - 'TERM': 'linux', 16:06:55 INFO - 'TMOUT': '86400', 16:06:55 INFO - 'USER': 'cltbld', 16:06:55 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1461020462.471051-1730854258', 16:06:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:55 INFO - '_': '/tools/buildbot/bin/python'} 16:06:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:55 INFO - Downloading/unpacking blobuploader==1.2.4 16:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:06:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:06:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:06:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:06:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:06:57 INFO - Downloading blobuploader-1.2.4.tar.gz 16:06:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:06:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:06:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:06:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:06:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:06:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:06:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:06:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:06:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:06:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:06:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:06:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:06:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:06:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:06:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:06:58 INFO - Downloading docopt-0.6.1.tar.gz 16:06:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:06:58 INFO - Installing collected packages: blobuploader, requests, docopt 16:06:58 INFO - Running setup.py install for blobuploader 16:06:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:06:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:06:58 INFO - Running setup.py install for requests 16:06:58 INFO - Running setup.py install for docopt 16:06:58 INFO - Successfully installed blobuploader requests docopt 16:06:58 INFO - Cleaning up... 16:06:59 INFO - Return code: 0 16:06:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:06:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:06:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:06:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06:59 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 0x7fbe04c69f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c1c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cab410>, '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 0x1cac310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cac7a0>, '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': 'df17445c3590ff7897617a0e00000225-1461020462.471051-1730854258', '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 16:06:59 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 16:06:59 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 16:06:59 INFO - Using env: {'DISPLAY': ':0', 16:06:59 INFO - 'HOME': '/home/cltbld', 16:06:59 INFO - 'LANG': 'en_US.UTF-8', 16:06:59 INFO - 'LANGUAGE': 'en_US:en', 16:06:59 INFO - 'LOGNAME': 'cltbld', 16:06:59 INFO - 'MAIL': '/var/mail/cltbld', 16:06:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:59 INFO - 'MOZ_NO_REMOTE': '1', 16:06:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:06:59 INFO - 'NO_EM_RESTART': '1', 16:06:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:06:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:59 INFO - 'PWD': '/builds/slave/test', 16:06:59 INFO - 'SHELL': '/bin/bash', 16:06:59 INFO - 'SHLVL': '1', 16:06:59 INFO - 'TERM': 'linux', 16:06:59 INFO - 'TMOUT': '86400', 16:06:59 INFO - 'USER': 'cltbld', 16:06:59 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1461020462.471051-1730854258', 16:06:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:59 INFO - '_': '/tools/buildbot/bin/python'} 16:06:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:06:59 INFO - Running setup.py (path:/tmp/pip-cVMxg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:06:59 INFO - Running setup.py (path:/tmp/pip-KxxIUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:06:59 INFO - Running setup.py (path:/tmp/pip-9eWYqM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:06:59 INFO - Running setup.py (path:/tmp/pip-OLNEZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:06:59 INFO - Running setup.py (path:/tmp/pip-K_pbyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:06:59 INFO - Running setup.py (path:/tmp/pip-nsa8Yd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:06:59 INFO - Running setup.py (path:/tmp/pip-ycFL49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:06:59 INFO - Running setup.py (path:/tmp/pip-VCxuMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:06:59 INFO - Running setup.py (path:/tmp/pip-KrWMgx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:06:59 INFO - Running setup.py (path:/tmp/pip-MxLk0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:06:59 INFO - Running setup.py (path:/tmp/pip-6TxmTF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:07:00 INFO - Running setup.py (path:/tmp/pip-nbrsC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:07:00 INFO - Running setup.py (path:/tmp/pip-XYl0pO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:07:00 INFO - Running setup.py (path:/tmp/pip-OsKu4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:07:00 INFO - Running setup.py (path:/tmp/pip-XZMeWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:07:00 INFO - Running setup.py (path:/tmp/pip-Mui5Ce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:07:00 INFO - Running setup.py (path:/tmp/pip-GEIpGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:07:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:07:00 INFO - Running setup.py install for manifestparser 16:07:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:07:00 INFO - Running setup.py install for mozcrash 16:07:00 INFO - Running setup.py install for mozdebug 16:07:00 INFO - Running setup.py install for mozdevice 16:07:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:07:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:07:00 INFO - Running setup.py install for mozfile 16:07:00 INFO - Running setup.py install for mozhttpd 16:07:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:07:01 INFO - Running setup.py install for mozinfo 16:07:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:07:01 INFO - Running setup.py install for mozInstall 16:07:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:07:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:07:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:07:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:07:01 INFO - Running setup.py install for mozleak 16:07:01 INFO - Running setup.py install for mozlog 16:07:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:07:01 INFO - Running setup.py install for moznetwork 16:07:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:07:01 INFO - Running setup.py install for mozprocess 16:07:01 INFO - Running setup.py install for mozprofile 16:07:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:07:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:07:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:07:01 INFO - Running setup.py install for mozrunner 16:07:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:07:01 INFO - Running setup.py install for mozscreenshot 16:07:02 INFO - Running setup.py install for moztest 16:07:02 INFO - Running setup.py install for mozversion 16:07:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:07:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:07:02 INFO - Cleaning up... 16:07:02 INFO - Return code: 0 16:07:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:07:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:02 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 0x7fbe04c69f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c1c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cab410>, '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 0x1cac310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cac7a0>, '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': 'df17445c3590ff7897617a0e00000225-1461020462.471051-1730854258', '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 16:07:02 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 16:07:02 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 16:07:02 INFO - Using env: {'DISPLAY': ':0', 16:07:02 INFO - 'HOME': '/home/cltbld', 16:07:02 INFO - 'LANG': 'en_US.UTF-8', 16:07:02 INFO - 'LANGUAGE': 'en_US:en', 16:07:02 INFO - 'LOGNAME': 'cltbld', 16:07:02 INFO - 'MAIL': '/var/mail/cltbld', 16:07:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:02 INFO - 'MOZ_NO_REMOTE': '1', 16:07:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:02 INFO - 'NO_EM_RESTART': '1', 16:07:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:02 INFO - 'PWD': '/builds/slave/test', 16:07:02 INFO - 'SHELL': '/bin/bash', 16:07:02 INFO - 'SHLVL': '1', 16:07:02 INFO - 'TERM': 'linux', 16:07:02 INFO - 'TMOUT': '86400', 16:07:02 INFO - 'USER': 'cltbld', 16:07:02 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1461020462.471051-1730854258', 16:07:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:02 INFO - '_': '/tools/buildbot/bin/python'} 16:07:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:07:02 INFO - Running setup.py (path:/tmp/pip-bRpovO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:07:02 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)) 16:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:07:02 INFO - Running setup.py (path:/tmp/pip-rd9FCv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:07:02 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)) 16:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:07:02 INFO - Running setup.py (path:/tmp/pip-7vZj_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:07:02 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)) 16:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:07:02 INFO - Running setup.py (path:/tmp/pip-qqX4Ko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:07:02 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)) 16:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:07:02 INFO - Running setup.py (path:/tmp/pip-MihXsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:07:02 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)) 16:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:07:02 INFO - Running setup.py (path:/tmp/pip-GtPnod-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:07:02 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)) 16:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:07:02 INFO - Running setup.py (path:/tmp/pip-t18NAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:07:02 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)) 16:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:07:02 INFO - Running setup.py (path:/tmp/pip-IFU5FQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:07:03 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)) 16:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:07:03 INFO - Running setup.py (path:/tmp/pip-kYav4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:07:03 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)) 16:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:07:03 INFO - Running setup.py (path:/tmp/pip-v19RXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:07:03 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)) 16:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:07:03 INFO - Running setup.py (path:/tmp/pip-3toRjx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:07:03 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)) 16:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:07:03 INFO - Running setup.py (path:/tmp/pip-S0ACTj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:07:03 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)) 16:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:07:03 INFO - Running setup.py (path:/tmp/pip-J80TAd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:07:03 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)) 16:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:07:03 INFO - Running setup.py (path:/tmp/pip-w0i4EL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:07:03 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)) 16:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:07:03 INFO - Running setup.py (path:/tmp/pip-xGoa61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:07:03 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)) 16:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:07:03 INFO - Running setup.py (path:/tmp/pip-oJL9Wk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:07:03 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)) 16:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:07:03 INFO - Running setup.py (path:/tmp/pip-nnN6TG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:07:03 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)) 16:07:03 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)) 16:07:03 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)) 16:07:03 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)) 16:07:03 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)) 16:07:03 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)) 16:07:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:07:03 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 16:07:03 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 16:07:03 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 16:07:03 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 16:07:03 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 16:07:03 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 16:07:05 INFO - Downloading blessings-1.6.tar.gz 16:07:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:07:05 INFO - Installing collected packages: blessings 16:07:05 INFO - Running setup.py install for blessings 16:07:05 INFO - Successfully installed blessings 16:07:05 INFO - Cleaning up... 16:07:05 INFO - Return code: 0 16:07:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:07:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:07:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:07:06 INFO - Reading from file tmpfile_stdout 16:07:06 INFO - Current package versions: 16:07:06 INFO - argparse == 1.2.1 16:07:06 INFO - blessings == 1.6 16:07:06 INFO - blobuploader == 1.2.4 16:07:06 INFO - docopt == 0.6.1 16:07:06 INFO - manifestparser == 1.1 16:07:06 INFO - mozInstall == 1.12 16:07:06 INFO - mozcrash == 0.17 16:07:06 INFO - mozdebug == 0.1 16:07:06 INFO - mozdevice == 0.48 16:07:06 INFO - mozfile == 1.2 16:07:06 INFO - mozhttpd == 0.7 16:07:06 INFO - mozinfo == 0.9 16:07:06 INFO - mozleak == 0.1 16:07:06 INFO - mozlog == 3.1 16:07:06 INFO - moznetwork == 0.27 16:07:06 INFO - mozprocess == 0.22 16:07:06 INFO - mozprofile == 0.28 16:07:06 INFO - mozrunner == 6.11 16:07:06 INFO - mozscreenshot == 0.1 16:07:06 INFO - mozsystemmonitor == 0.0 16:07:06 INFO - moztest == 0.7 16:07:06 INFO - mozversion == 1.4 16:07:06 INFO - psutil == 3.1.1 16:07:06 INFO - requests == 1.2.3 16:07:06 INFO - wsgiref == 0.1.2 16:07:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16: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')]} 16:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16: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')]} 16:07:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:06 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 0x7fbe04c69f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c1c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cab410>, '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 0x1cac310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cac7a0>, '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': 'df17445c3590ff7897617a0e00000225-1461020462.471051-1730854258', '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 16:07:06 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 16:07:06 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 16:07:06 INFO - Using env: {'DISPLAY': ':0', 16:07:06 INFO - 'HOME': '/home/cltbld', 16:07:06 INFO - 'LANG': 'en_US.UTF-8', 16:07:06 INFO - 'LANGUAGE': 'en_US:en', 16:07:06 INFO - 'LOGNAME': 'cltbld', 16:07:06 INFO - 'MAIL': '/var/mail/cltbld', 16:07:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:06 INFO - 'MOZ_NO_REMOTE': '1', 16:07:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:06 INFO - 'NO_EM_RESTART': '1', 16:07:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:06 INFO - 'PWD': '/builds/slave/test', 16:07:06 INFO - 'SHELL': '/bin/bash', 16:07:06 INFO - 'SHLVL': '1', 16:07:06 INFO - 'TERM': 'linux', 16:07:06 INFO - 'TMOUT': '86400', 16:07:06 INFO - 'USER': 'cltbld', 16:07:06 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1461020462.471051-1730854258', 16:07:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:06 INFO - '_': '/tools/buildbot/bin/python'} 16:07:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:06 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)) 16:07:06 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)) 16:07:06 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)) 16:07:06 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)) 16:07:06 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)) 16:07:06 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)) 16:07:06 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)) 16:07:06 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)) 16:07:06 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)) 16:07:06 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)) 16:07:06 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)) 16:07:06 INFO - Cleaning up... 16:07:06 INFO - Return code: 0 16:07:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16: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')]} 16:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16: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')]} 16:07:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:06 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 0x7fbe04c69f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c1c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cab410>, '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 0x1cac310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cac7a0>, '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': 'df17445c3590ff7897617a0e00000225-1461020462.471051-1730854258', '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 16:07:06 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 16:07:06 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 16:07:06 INFO - Using env: {'DISPLAY': ':0', 16:07:06 INFO - 'HOME': '/home/cltbld', 16:07:06 INFO - 'LANG': 'en_US.UTF-8', 16:07:06 INFO - 'LANGUAGE': 'en_US:en', 16:07:06 INFO - 'LOGNAME': 'cltbld', 16:07:06 INFO - 'MAIL': '/var/mail/cltbld', 16:07:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:06 INFO - 'MOZ_NO_REMOTE': '1', 16:07:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:06 INFO - 'NO_EM_RESTART': '1', 16:07:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:06 INFO - 'PWD': '/builds/slave/test', 16:07:06 INFO - 'SHELL': '/bin/bash', 16:07:06 INFO - 'SHLVL': '1', 16:07:06 INFO - 'TERM': 'linux', 16:07:06 INFO - 'TMOUT': '86400', 16:07:06 INFO - 'USER': 'cltbld', 16:07:06 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1461020462.471051-1730854258', 16:07:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:06 INFO - '_': '/tools/buildbot/bin/python'} 16:07:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:06 INFO - Downloading/unpacking jsonschema 16:07:06 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 16:07:06 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 16:07:06 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 16:07:06 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 16:07:06 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 16:07:06 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 16:07:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:07:08 INFO - Downloading/unpacking functools32 (from jsonschema) 16:07:08 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 16:07:08 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 16:07:08 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 16:07:08 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 16:07:08 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 16:07:08 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 16:07:08 INFO - Downloading functools32-3.2.3-2.tar.gz 16:07:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:07:08 INFO - warning: no files found matching '*.txt' 16:07:08 INFO - no previously-included directories found matching 'build' 16:07:08 INFO - no previously-included directories found matching 'dist' 16:07:08 INFO - no previously-included directories found matching '.git*' 16:07:08 INFO - Installing collected packages: jsonschema, functools32 16:07:08 INFO - Running setup.py install for functools32 16:07:08 INFO - warning: no files found matching '*.txt' 16:07:08 INFO - no previously-included directories found matching 'build' 16:07:08 INFO - no previously-included directories found matching 'dist' 16:07:08 INFO - no previously-included directories found matching '.git*' 16:07:08 INFO - Successfully installed jsonschema functools32 16:07:08 INFO - Cleaning up... 16:07:08 INFO - Return code: 0 16:07:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:07:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:07:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:07:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:07:08 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 0x7fbe04c69f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c1c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cab410>, '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 0x1cac310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cac7a0>, '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': 'df17445c3590ff7897617a0e00000225-1461020462.471051-1730854258', '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 16:07:08 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 16:07:08 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 16:07:08 INFO - Using env: {'DISPLAY': ':0', 16:07:08 INFO - 'HOME': '/home/cltbld', 16:07:08 INFO - 'LANG': 'en_US.UTF-8', 16:07:08 INFO - 'LANGUAGE': 'en_US:en', 16:07:08 INFO - 'LOGNAME': 'cltbld', 16:07:08 INFO - 'MAIL': '/var/mail/cltbld', 16:07:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:08 INFO - 'MOZ_NO_REMOTE': '1', 16:07:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:08 INFO - 'NO_EM_RESTART': '1', 16:07:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:08 INFO - 'PWD': '/builds/slave/test', 16:07:08 INFO - 'SHELL': '/bin/bash', 16:07:08 INFO - 'SHLVL': '1', 16:07:08 INFO - 'TERM': 'linux', 16:07:08 INFO - 'TMOUT': '86400', 16:07:08 INFO - 'USER': 'cltbld', 16:07:08 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1461020462.471051-1730854258', 16:07:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:08 INFO - '_': '/tools/buildbot/bin/python'} 16:07:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:07:09 INFO - Downloading/unpacking flake8 16:07:09 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 16:07:09 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 16:07:09 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 16:07:09 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 16:07:09 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 16:07:09 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 16:07:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:07:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:07:10 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 16:07:10 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 16:07:10 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 16:07:10 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 16:07:10 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 16:07:10 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 16:07:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:07:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:07:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:07:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:07:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:07:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:07:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:07:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:07:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:07:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:07:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:07:11 INFO - no previously-included directories found matching 'docs/_build' 16:07:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:07:11 INFO - Running setup.py install for pep8 16:07:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:07:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:07:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:07:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:07:11 INFO - no previously-included directories found matching 'docs/_build' 16:07:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:07:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:07:11 INFO - Cleaning up... 16:07:11 INFO - Return code: 0 16:07:11 INFO - Running post-action listener: _resource_record_post_action 16:07:11 INFO - Running post-action listener: _start_resource_monitoring 16:07:11 INFO - Starting resource monitoring. 16:07:11 INFO - ##### 16:07:11 INFO - ##### Running install step. 16:07:11 INFO - ##### 16:07:11 INFO - Running pre-action listener: _resource_record_pre_action 16:07:11 INFO - Running main action method: install 16:07:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:07:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:07:12 INFO - Reading from file tmpfile_stdout 16:07:12 INFO - Detecting whether we're running mozinstall >=1.0... 16:07:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:07:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:07:12 INFO - Reading from file tmpfile_stdout 16:07:12 INFO - Output received: 16:07:12 INFO - Usage: mozinstall [options] installer 16:07:12 INFO - Options: 16:07:12 INFO - -h, --help show this help message and exit 16:07:12 INFO - -d DEST, --destination=DEST 16:07:12 INFO - Directory to install application into. [default: 16:07:12 INFO - "/builds/slave/test"] 16:07:12 INFO - --app=APP Application being installed. [default: firefox] 16:07:12 INFO - mkdir: /builds/slave/test/build/application 16:07:12 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'] 16:07:12 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 16:07:27 INFO - Reading from file tmpfile_stdout 16:07:27 INFO - Output received: 16:07:27 INFO - /builds/slave/test/build/application/firefox/firefox 16:07:27 INFO - Running post-action listener: _resource_record_post_action 16:07:27 INFO - ##### 16:07:27 INFO - ##### Running run-tests step. 16:07:27 INFO - ##### 16:07:27 INFO - Running pre-action listener: _resource_record_pre_action 16:07:27 INFO - Running main action method: run_tests 16:07:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:07:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:07:27 INFO - Python 2.7.3 16:07:27 INFO - Return code: 0 16:07:27 INFO - grabbing minidump binary from tooltool 16:07:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:07:27 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 0x1cab410>, '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 0x1cac310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cac7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:07:27 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 16:07:27 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 16:07:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:07:28 INFO - Return code: 0 16:07:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:07:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:07:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:07:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:07:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:07:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:07:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:07:29 INFO - Return code: 0 16:07:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cmUiJAjeQkqAWz0c_cpDTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 16:07:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cmUiJAjeQkqAWz0c_cpDTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --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 16:07:29 INFO - Using env: {'DISPLAY': ':0', 16:07:29 INFO - 'HOME': '/home/cltbld', 16:07:29 INFO - 'LANG': 'en_US.UTF-8', 16:07:29 INFO - 'LANGUAGE': 'en_US:en', 16:07:29 INFO - 'LOGNAME': 'cltbld', 16:07:29 INFO - 'MAIL': '/var/mail/cltbld', 16:07:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:07:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:07:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:07:29 INFO - 'MOZ_NO_REMOTE': '1', 16:07:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:07:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:07:29 INFO - 'NO_EM_RESTART': '1', 16:07:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:07:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:07:29 INFO - 'PWD': '/builds/slave/test', 16:07:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:07:29 INFO - 'SHELL': '/bin/bash', 16:07:29 INFO - 'SHLVL': '1', 16:07:29 INFO - 'TERM': 'linux', 16:07:29 INFO - 'TMOUT': '86400', 16:07:29 INFO - 'USER': 'cltbld', 16:07:29 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1461020462.471051-1730854258', 16:07:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:07:29 INFO - '_': '/tools/buildbot/bin/python'} 16:07:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cmUiJAjeQkqAWz0c_cpDTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 16:07:29 INFO - mozversion application_buildid: 20160418142321 16:07:29 INFO - mozversion application_changeset: dadd3d52a252edd85975ff73ac404325d28598b2 16:07:29 INFO - mozversion application_display_name: Nightly 16:07:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:07:29 INFO - mozversion application_name: Firefox 16:07:29 INFO - mozversion application_remotingname: firefox 16:07:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:07:29 INFO - mozversion application_vendor: Mozilla 16:07:29 INFO - mozversion application_version: 48.0a1 16:07:29 INFO - mozversion platform_buildid: 20160418142321 16:07:29 INFO - mozversion platform_changeset: dadd3d52a252edd85975ff73ac404325d28598b2 16:07:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:07:29 INFO - mozversion platform_version: 48.0a1 16:07:29 INFO - using testdate: 1461020849 16:07:29 INFO - actual date: 1461020849 16:07:29 INFO - starting webserver on 'localhost:44621' 16:07:29 INFO - SUITE-START | Running 2 tests 16:07:29 INFO - TEST-START | dromaeo_css 16:07:29 INFO - operating with platform_type : linux_ 16:07:29 INFO - Initialising browser for dromaeo_css test... 16:07:29 INFO - TEST-INFO | started process 25872 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzYfDHR/profile http://localhost:44621/getInfo.html) 16:07:34 INFO - PROCESS | 25872 | __metrics Screen width/height:1600/1200 16:07:34 INFO - PROCESS | 25872 | colorDepth:24 16:07:34 INFO - PROCESS | 25872 | Browser inner width/height: 1024/697 16:07:34 INFO - PROCESS | 25872 | __metrics 16:07:36 ERROR - PROCESS | 25872 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:07:36 INFO - TEST-INFO | 25872: exit 0 16:07:36 INFO - Browser initialized. 16:07:36 INFO - Running cycle 1/1 for dromaeo_css test... 16:07:36 INFO - TEST-INFO | started process 25952 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzYfDHR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:07:48 INFO - PROCESS | 25952 | RSS: Main: 154804224 16:07:48 INFO - PROCESS | 25952 | 16:08:40 INFO - PROCESS | 25952 | 1461020920157 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] 16:10:51 INFO - PROCESS | 25952 | Cycle 1(1): loaded http://localhost:44621/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44621/tests/dromaeo/cssquery-ext.html) 16:10:52 INFO - PROCESS | 25952 | RSS: Main: 238923776 16:10:52 INFO - PROCESS | 25952 | 16:13:54 INFO - PROCESS | 25952 | Cycle 1(1): loaded http://localhost:44621/tests/dromaeo/cssquery-ext.html (next: http://localhost:44621/tests/dromaeo/cssquery-jquery.html) 16:13:55 INFO - PROCESS | 25952 | RSS: Main: 242319360 16:13:55 INFO - PROCESS | 25952 | 16:16:57 INFO - PROCESS | 25952 | Cycle 1(1): loaded http://localhost:44621/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44621/tests/dromaeo/cssquery-mootools.html) 16:16:57 INFO - PROCESS | 25952 | RSS: Main: 242139136 16:16:57 INFO - PROCESS | 25952 | 16:19:59 INFO - PROCESS | 25952 | Cycle 1(1): loaded http://localhost:44621/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44621/tests/dromaeo/cssquery-prototype.html) 16:20:00 INFO - PROCESS | 25952 | RSS: Main: 232001536 16:20:00 INFO - PROCESS | 25952 | 16:23:03 INFO - PROCESS | 25952 | Cycle 1(1): loaded http://localhost:44621/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44621/tests/dromaeo/cssquery-yui.html) 16:23:03 INFO - PROCESS | 25952 | RSS: Main: 210608128 16:23:03 INFO - PROCESS | 25952 | 16:26:06 INFO - PROCESS | 25952 | Cycle 1(1): loaded http://localhost:44621/tests/dromaeo/cssquery-yui.html (next: http://localhost:44621/tests/dromaeo/cssquery-dojo.html) 16:26:06 INFO - PROCESS | 25952 | RSS: Main: 269475840 16:26:06 INFO - PROCESS | 25952 | 16:26:06 INFO - PROCESS | 25952 | __start_tp_report 16:26:06 INFO - PROCESS | 25952 | _x_x_mozilla_page_load 16:26:06 INFO - PROCESS | 25952 | _x_x_mozilla_page_load_details 16:26:06 INFO - PROCESS | 25952 | |i|pagename|runs| 16:26:06 INFO - PROCESS | 25952 | |0;dojo.html;2584.5218634552602;2664.147472808701;2673.8262012969167;2679.6650418697664;2705.161399966011;4537.8638640840745;4608.792604332804;4619.23782575875;4636.65225108117;4651.488336283006;4610.23931051377;4641.698289611173;4649.163150632885;4681.9297710534365;4708.74101924394;4228.746275223496;4278.978605106978;4311.417958575599;4342.066455712022;4399.890002749941;4312.310030395138;4340.8697739067875;4358.324459708734;4369.672274579403;4407.360932664762;4196.874093777207;4252.447181866338;4267.167902259061;4292.141571685675;4341.717788343748;4194.580541945811;4199.475065616798;4204.831806727758;4214.494260688737;4238.173556156551;4186.832526698929;4194.056337324108;4207.684423668237;4233.026403927114;4241.681873859442;4396.120775844844;4512.345709872083;4548.704334218299;4605.516420775837;4613.008203236321;4961;4971.0803501352;4973.850784476435;4977.502249774993;5002.52476014778;4869.220924652074;4992.201247800371;4993.176125939216;4997.475265097149;5000.62495312853;4657.673962822604;4711.2226482629985;4711.646626503026;4758.381410416693;4760.5715485606115;5097.6941383517105;5128.076946149654;5128.820491282787;5130.12787826063;5180.792768289301;4729.196036673774;4898.53463920927;4923.458419573844;4925.088858561177;4930.975345123252;4878.658493905464;4894.290327902434;4897.167481528078;4922.483139270396;4943.382077240345;4828.758562071883;4830.3237546743485;4833.661643684979;4837.129316722953;4901.313816065754;4811.759412029384;4816.253480710496;4870.0746858096845;4909.582685471775;4984.2025275955675;4162.646175075092;4173.061061261192;4180.268453020709;4208.810603522848;4210.221109094828;3642.307961487309;3644.927101457956;3647.7446578739764;3674.2284120334493;3688.170161713593;4185.079282557833;4220.85227017053;4222.535521092677;4233.936490952638;4264.402983582301;4966.478519755446;4972.453030166679;4990.72551009698;4994.600431965434;5009.524095210949;4280.785960701953;4283.892902677396;4284.507281662649;4303.33298338758;4338.717983331074;4336.1978034063795;4426.203283408953;4476.686631935799;4479.7536135512855;4531.365608814768;4674.485806561275;4676.392069031141;4686.8125274988615;4694.342792009122;4745.145873742759;4954.232094025432;4962.429320628174;4964.106460837084;4968.726720030433;5027.195648696191;4618.861434156981;4634.397528321297;4670.392848929618;4670.579647831712;4700.55344742249;4813.927791083067;4817.638677099301;4839.467658557626;4839.7096174229655;4882.414110306786;4770.212914869007;4885.877853053702;4911.115999120193;4911.312416261655;4962.082014827269;4813.061453016629;4833.589144922721;4839.056384005226;4849.927251091307;4884.5603895649565;4764.047190561971;4768.4754676986195;4771.117343291502;4773.284007398918;4846.273059041172;4619.491855895782;4708.081924024919;4710.505396933273;4715.929261061018;4757.286407038971;4812.5187481253;4822.927656085231;4826.8069277228515;4829.589484893683;4876.487968763229;4726.763661816826;4739.857804265877;4740.051989602162;4743.193657078236;4790.7365094920115 16:26:06 INFO - PROCESS | 25952 | |1;ext.html;576.3170642788297;589.3428826858053;605.9515238780898;621.4375989729293;642.2453617000027;27444.313892152706;28149.718502814965;34513.48229776552;35448.82275588618;35631.10922226946;37140;37686.811565942204;37748.43377349335;37869.431958520574;37903;7568.659410326521;7745;7748.496347737379;7749.496282741604;7753.340966017895;7687.923120768804;7799.688012479494;7817.022872140982;7820.608969551499;7822.100458447266;7925.9603701981405;7993.360531157523;8000.839983200332;8001.7199398021085;8002.279794818465;7898.210178982114;7954.482958607701;7968.521888686669;7972.521648701038;7980.201979802031;7767.96116019422;7870.370370370414;7871.724489642835;7879.172686867911;7886.64510097047;37241.068973275615;37434.62565374366;37690;37827.4325885112;37863.05342366435;2936.544835550493;2968.435997160554;3003.6695963444004;3156.4476216662224;3273.2307907641684;28880;29306.853465732747;29639.105978396008;29644.555331670043;29761.25596860074;3332.383509050809;3368.0569440556683;3412.8197340052125;3461.584609846809;3480.8781692640637;235234;235616;236861;237125;237246.8137659318;32739.181520462178;52162.73918630383;52375.47624523782;52438.213426798626;52516;31329.68670313313;31419.528707069414;31502.212444689067;31606;31620.683793161774;11675.182737208484;11813.527458901719;11880.108991825648;11893.88106118945;11897.286162830258;9611.231101511863;9661.033896610283;9692.32153749245;9692.660756873476;9716.271279654055;7967.56178410193;8135.877961830577;8162;8215.753527394188;8237.135100814328;3200.8239546824684;3226.451503244454;3240.902772916816;3244.724198443159;3251.349730053999;873.6680061576687;946.3091942881734;987.8107322963607;1000.4347543637822;1054.488573042074;28318;28495.43009139847;28514.429711405657;28795.28011799722;29095.56356654652;1020.6223697232072;1073.7906108308805;1103.051375816797;1124.5501799280353;1124.6176300057855;14771.63070923214;15172.696546069017;15284.235788210544;15336.539903802905;15560.299786509635;341066;347459;348943;349053;349164;49029.509704903205;49827.25259121116;49839.25241121386;49839.25241121386;49888;1065.9040686338267;1130.1636788776245;1205.4153735438306;1259.0997436832708;1286.5175559165314;25043.87478062598;26104.8694756525;27690.861545692143;28015.43969120647;28096.71903281023;38270.42594361031;38672;38792.41811372888;38828.41757373698;38889.222215556096;222845;224032;224233;225104.12135575176;226106;22645.43386415353;24945.75054249434;24974.875125624254;26049.609255861556;26087.478250435266;36365.27269454649;36446.635533645385;36928.81535592305;37217.25565488729;37471.62528374681;31435.371292574477;31807.36385272328;31960.520592191602;32060.358792824478;32120.839395802872;31256.843715781277;31855.681443185273;31969;32102.678973209968;32132.518012230303;33213.50179747257;33428;33709.662903370656;33852.49221261634;34067.318653627284;29533.556996645497;30790.692093078782;30878.22804429907;31077;31172;23277.3016809496;23845.642315364938;24238.75761242365;24280.635790462802;24496.14263500769 16:26:06 INFO - PROCESS | 25952 | |2;jquery.html;371.62280285510195;376.71746190357226;384.9826757795899;385.8167370499012;387.9592642772509;15957.760633590491;16517.174141292933;16836.66326673469;16839.32642694291;16864.072476013815;11184.608538701146;11195.328280303187;11209;11212.04697600705;11261.831072533898;4654.0924519718665;4759.619230461572;4790.568848803607;4793.9520604794025;4864.562189402953;4638.791254393544;4775.044991001813;4775.188218002948;4776.8566942991765;4789.0661321042235;4738.549837765407;4773.284007398901;4788.018456216468;4954.925676114861;5199.922001169985;5077.238414237875;5153.2270159476;5174.172132458826;5191.143461328877;5222.060029194743;4425.645948324126;4687.039156972813;4699.036697477009;4701.4828368879735;4718.740469274188;12163.635090947286;12292.446839892136;12319.137660363778;12458.626241212778;12554.560590379293;1688.2571668465835;1778.2353587957173;1894.6116046210493;1931.3433432632971;1987.3640435060786;9042.095790420972;9176.403533770284;9261.351705380626;9463.337566370357;9482.905170948272;1684.6630673865154;1707.6840784454791;1737.1922056243782;1743.8692098092695;1798.5413719501573;65794;67884;67903;68950;69948.65025674838;8190.467619604707;8847;8913.331500137516;9099.636014559343;10306.793864122676;11695.415229238504;11777.705557361134;11810.763784724257;11869.821952670716;11872.228305160137;6419.775307864203;6619.867602648016;6633.834154146089;6758.155230596176;6798.456123510107;6194.5044396448175;6201.441870231701;6248.28144763349;6512.967435162794;6590.835229119214;3823.3500304948225;3847.576766555677;3855.4602355670227;3902.35611124167;3945.1715139820385;1804.305342443169;1882.9811701882807;1894.990525047366;1903.1626084522766;1943.4461178564325;770.460677525723;826.6569373709843;834.6744769539885;852.53110789067;934.5233930695395;15898.443554475769;16676.684931370823;16700.96912778509;16798.916005419895;16946.152692365333;832.1470492744985;849.3417601358997;859.9699010534727;864.1660797330607;926.1340646495548;8727.476351418934;9232.95383523078;9471.384360016576;9498.762530936781;9734.561944712505;391205;396998;408702;415901;416851;48804.7559762206;78892;80555.59722201352;81270.59364703257;81879.5906020466;881.8342151675515;892.9464232145962;899.8110396816611;907.5915837872983;909.9909000910038;14691.801614395887;14752;14754;14824.25878706082;15188.088714677155;32604.655809771397;32879.178020549676;33491.162720932174;33928.83035584806;34006.3198736019;47712.761436192595;48127.518724812304;48187.5181248183;48207.276890847366;48400.27399588939;6801.2858649841055;7272.927270727225;7440.404767618686;7978;8150.796230094295;11496.195266331277;11564.248323858923;11565.537378504765;11853.585124520945;11941.223820451643;9939.353941993748;10021.899781002097;10199.28604997643;10298.845517317395;10401.791964160826;10291.382517049002;10397.948010259901;10493.527791249564;10736;10844.566217351534;10578.100861426865;10778.353298802096;10926.453677316262;11048.889511104786;11100.666979990614;7328.413726901942;7354.926450735638;7390.519616225143;7424.925750742424;7628.275313845176;8685.435446695945;10721;10816.891831081903;10853;11069.059129974043 16:26:06 INFO - PROCESS | 25952 | |3;mootools.html;1255.9246445213282;1382.7441923244198;1446.5804916574193;1583.5803512069297;1816.7002444596642;7613.771586852389;7978.840423191533;7985.161558036402;7988.081370642378;7996.48022878514;7741.57421341826;7915.722949696762;7929.326007289387;7943.483673561214;7946.5232086074875;1838.6138910828743;1907.0655378864396;2115.4605575578207;2181.6073106840763;2215.0253888289103;2221.7000704904794;2243.6971008913833;2244.842860999731;2247.056236380724;2247.1797793805226;2174.5650869826018;2198.461376962646;2202.878841663708;2205.8014778669917;2206.117552978805;1809.5023868436153;2059.1145807302855;2113.5350222950924;2122.448163477507;2149.7850214978457;2169.5443956769095;2172.728408948881;2194.1771835561663;2196.560687862418;2199.3841724317217;7720.922790772077;7847.450678452511;7861.48900321483;7866.488678235896;7872.370210383156;4645.303204519315;4803.471618122004;4816.783244753994;4817.686850354716;4846.103470857903;2935.985320073386;2962.6296712910885;2997.5203967365337;3054.7403470705017;3057.495513240313;886.8137691084816;888.7467071884547;904.9638014479413;922.8938672052733;928.5264515097349;10919.12646988239;10926.289791163548;10934.179936504714;10951.83572246417;11051;4258.957410425918;4374.496932852699;4515.322701594787;4540.636749060067;4541.409616749801;9266.490343031062;9274.721758347125;9289.814203716023;9300.255979521622;9322.720318390458;4936.975315123474;4940.382452193476;4951.257311403318;4957.380327459067;4961.131801934647;3709.795961222105;4230;4305.655547556188;4318.632916202095;4343.869683909487;3610.512580801558;3658.396364599811;3733.5519737631657;3767.472553842464;3772.1135533149686;1199.598134624893;1213.4782043721284;1214.8785121487958;1215.197969340231;1226.2274766896799;783.647358688581;881.5151666583354;887.6759982606302;911.2345629671108;921.9308551858503;5165.251038599457;5226.085435048927;5254.842354729364;5274.630775845731;5699.287589051369;857.4897935728231;861.7587075618836;902;961.4808003678075;963.720521048902;3930.115723962143;3946.782926939046;3949.822257998397;4005.439238506611;4014.8594799182474;9552.092551207763;9945.651902183388;10034.147097496649;10082.59669613222;10111;9936.056074672895;9942.105210530943;9991.900080999243;9999.050090241415;10018.098371146632;7398.815029624195;7537.736179233701;7546;7562.432817538706;7562.470627056164;5186.507281808223;5498.835034948958;5550.888982220252;5569.916451253153;5669.34802497718;8632.568371581521;8727.389082764399;8806.691765788166;8832.64669413242;8977.640894364153;8911.688090916787;9067.591958362022;9238.722838314861;9282;9341.299402544972;6034.7284372202475;6218.844528886814;6220.813375598739;6648.6343251119715;6777.762778302736;6681.164854393201;6936.895946560907;7596.164421913696;7630.923690763021;7636.732714354971;6703.463722902058;6762.661866906733;6809.182898052265;6826.897596536155;6870.484713646397;6460.160179176677;6650.534462587572;6698.899516507159;6735.966320168368;6787.490938179755;6562.8359291018105;6569.967150164219;6651.866962660622;6652.268250492539;6653.900191497229;4573.931391029204;4715.764211789466;4740.3837501124635;4747.928781068355;4768.237082066853;4835.637327200404;4867.464578896389;4890.633202509897;4917.385326834145;5000.474950130184 16:26:06 INFO - PROCESS | 25952 | |4;prototype.html;306.947818870792;307.1920848169314;307.2135333546122;314.6130259780471;316.892256632745;5015.598752099832;5031.622628302874;5043.546080852722;5050.141475949088;5052.267421223925;4965.900681986358;4974.6269029822815;4975.964661556448;4981.37732783402;4984.601231901448;3736.178040831013;3843.1545060086737;3850.132685647459;3918.921621567567;3988.9601103989025;3926.155876486555;3975.1254723960683;3975.3838155085864;3976.230577393061;3982.4623675803687;3732.5147730795093;3937.7243592948507;3938.940915886264;3960.3663413853787;3963.324755789845;3786.8106594670157;3941.7240793144633;3952.1898010907694;3958.940615890764;3963.8810835674976;3501.5973163086314;3505.789652620851;3507.8424120040327;3508.3860324443376;3520.06718219672;4847.757612119415;4850.733209673466;4853.199222128344;4866.270059491069;4878.414590249157;4224.5353011168745;4453.176162409932;4458.464984201884;4479.8800299925015;4527;5250.9474905250845;5254.211868219798;5264.684118952875;5267.420583735786;5268.394134674485;3712.3317802795486;3716.609755975611;3719.8698045568276;3723.087843478338;3728.3475391806323;5254.579633629301;5460;5541.639793413416;5543.085390910495;5543.722813859331;3790.3745881929726;3791.8672846450795;3811.1424929390664;3813.237352529505;3822.1462590643514;3849.942250866239;3860.749051311656;3862.663088831273;3869.5163104611925;3869.941950870739;4222.155568886174;4383.9342409863875;4396.120775844844;4402.295632698753;4405.735655860659;5196.792128314825;5238.240455133984;5244.187150991603;5251;5260;1316.486570237608;1338.4980632262902;1339.1161833190047;1340.477213886585;1342.7515909556764;845.8688903220011;889.8042430665244;891.3448615267773;898.9011208767031;905.6649039855164;4567.383403240587;4574;4597.356370108188;4600.631949444037;4609.8847528811375;5365.631763900181;5374;5379.408265090837;5382.542483888835;5385.946140538623;4480.4623445186135;4566.246569316092;4577.496475387705;4577.496475387705;4603.424571928509;2867.4121805029918;2878.6401699787525;2882.6829048804616;2892.363679990399;2905.78206634499;5049.141645920203;5058.114829904752;5065.544101030851;5081.74591270435;5082.237664350303;5266.8156614519075;5463.972680136574;5478.863028424242;5489.670619762827;5492.121260598365;5028.321176641107;5062.721550314768;5063.670861393997;5071.619628527875;5072.898542029213;5301.469853014668;5343.866403339792;5387.218853266333;5394.541463975606;5400.135978243619;5156.5909702362205;5176.171812509981;5240.266362709148;5266.552343050884;5304.098303288527;5047.2429135629945;5049.31834202378;5060.49395060491;5067.290579318825;5070.4929507049;3771.283456143324;3788.6211378861894;3809.6380843819793;3816.255830113212;3828.9617103828605;5122.231665250242;5361.142217245222;5370.409254982027;5371.0869152244995;5382.434844341287;5202.1416466282635;5210.452902445189;5213.765380557808;5218.739063046756;5226.294450249167;5217.617331407256;5219;5222.086134926449;5228.607854410859;5232.555232805102;4922.704637721748;5118.616103792156;5138.511841375063;5141.203113517411;5144.202648589475;5046.142155833591;5148.176291793295;5254.925868366895;5262.42113367537;5271.815486457956;5175.120229561059;5177.792888284426;5213.6350455467755;5217.834598641522;5232.241325007776 16:26:06 INFO - PROCESS | 25952 | |5;yui.html;748.9363404110651;761.299604363985;761.9276168763968;776.3866545429107;784.9372050235982;11175.552977880876;11446.599369022086;11450.770984580304;11454.770904581903;11456;11232;11264.211505194618;11280.435978201078;11299.378534180616;11328.207025508218;643.6717274190173;785.9921400786005;789.4828887078972;810.8013536683521;820.4953953318695;810.2140923304415;815.0382548592659;816.2979837339883;817.0807841178674;817.3869597801648;859.909709480505;862.7584276402617;863.3395452478859;865.0052439694339;865.4547634989948;601.6931365003858;628.7390732845886;830.6428235858579;856.4518708026868;858.2747578296361;628.8679377330766;631.2425089892148;633.1136409027353;633.9904901426482;634.112242859995;11452.828207576893;11485.253458525252;11492.482838272297;11501.367424791633;11574.768504629861;12251.387430628432;12331.691707707289;12724.427400766896;12902.161359511696;13132.606021819362;9626.518674066268;9698.75753106178;10153.390796552156;11073.612423565137;11304.321740695503;3238.70851623355;3263.8694452221885;3270.1824543864036;3321.9169520761934;3346.983265083659;41369.58630413687;44537.777311113234;44717.55282447166;45703.54296457026;45737.54262457366;9844.261680374;9960.601575937026;9973.551190196458;10190.388576685422;10229.851731136396;16980.830191698173;17004.574885627957;17016.914915425343;17038.74441883373;17208.483745487654;6358.332375100548;6491.285958544557;6491.610503369813;6618.7021584028835;6731.966340168366;3722.553293604785;3748.5314335708035;3802.049487628093;3841.4429907663234;3876.7673939563715;2958.9112326630234;3046.969530304713;3050.5119180930947;3054.129573071664;3060.219643990768;548.3693752185019;552.0862971781708;556.7383329834971;570.7574280930588;572.7651662818308;488.3529323646183;555.0203890133917;632.9872204472807;635.6662752055208;640.9230892292954;7382.409407247407;7645.923540764632;7964.402669799788;7972.920270797218;8149.225823546753;520.5055197562331;565.21435205065;602.7076867719153;609.6707777800027;614.4746241963146;3731.7014638828828;3849.287881741887;3902.941455878164;3926.371780515104;3944.822482988215;46296.537034629895;46311.768441157576;46381.30428043582;46779;50128.498715012385;41762.58237417587;46103;46393;46575.30137047947;46668.29997550039;37232.44151337732;37404.81297593495;38882.416763748566;39003.80498097491;40526.39210411846;8054.5569993650915;8193.344532437271;8338.166183381856;8419.242268195892;8507.276881465144;26063.609045864705;26436.471270574097;26741.331466713487;26861.865690672203;26894.73105268922;35257.471137932436;35503.46744798882;38280.04299892525;38555.80722096484;38813.805930970164;9780.696493542819;10172.13536849376;10184.338018028804;10213.234007449322;10378.169746420419;11858;11901.345426001653;12040;12085.395730213279;12695.619131426072;11042.503087361249;11145.164112691418;11224.55101795919;11670.649880503599;11800.940995294968;10135.239857010902;10305.484725763832;10309.123724483503;10493.475326233505;10555.472226388496;11187.776244475228;11290.43547822622;11358.09135269193;11777.52889884395;11902.40487975615;9024.503652299187;9295.163435290857;9468.905310946802;9470.905290947003;9643;9082.863757043782;9227.677031303872;9273.165415112673;9320.906790932004;9423.151916327564 16:26:06 INFO - PROCESS | 25952 | __end_tp_report 16:26:06 INFO - PROCESS | 25952 | __start_cc_report 16:26:06 INFO - PROCESS | 25952 | _x_x_mozilla_cycle_collect,853 16:26:06 INFO - PROCESS | 25952 | __end_cc_report 16:26:07 INFO - PROCESS | 25952 | __startTimestamp1461021966984__endTimestamp 16:26:07 INFO - PROCESS | 25952 | 16:26:07 INFO - PROCESS | 25952 | ------- Summary: start ------- 16:26:07 INFO - PROCESS | 25952 | Number of tests: 6 16:26:07 INFO - PROCESS | 25952 | 16:26:07 INFO - PROCESS | 25952 | [#0] dojo.html Cycles:165 Average:4573.30 Median:4710.51 stddev:467.51 (9.9%) stddev-sans-first:442.14 16:26:07 INFO - PROCESS | 25952 | Values: 2584.5 2664.1 2673.8 2679.7 2705.2 4537.9 4608.8 4619.2 4636.7 4651.5 4610.2 4641.7 4649.2 4681.9 4708.7 4228.7 4279.0 4311.4 4342.1 4399.9 4312.3 4340.9 4358.3 4369.7 4407.4 4196.9 4252.4 4267.2 4292.1 4341.7 4194.6 4199.5 4204.8 4214.5 4238.2 4186.8 4194.1 4207.7 4233.0 4241.7 4396.1 4512.3 4548.7 4605.5 4613.0 4961.0 4971.1 4973.9 4977.5 5002.5 4869.2 4992.2 4993.2 4997.5 5000.6 4657.7 4711.2 4711.6 4758.4 4760.6 5097.7 5128.1 5128.8 5130.1 5180.8 4729.2 4898.5 4923.5 4925.1 4931.0 4878.7 4894.3 4897.2 4922.5 4943.4 4828.8 4830.3 4833.7 4837.1 4901.3 4811.8 4816.3 4870.1 4909.6 4984.2 4162.6 4173.1 4180.3 4208.8 4210.2 3642.3 3644.9 3647.7 3674.2 3688.2 4185.1 4220.9 4222.5 4233.9 4264.4 4966.5 4972.5 4990.7 4994.6 5009.5 4280.8 4283.9 4284.5 4303.3 4338.7 4336.2 4426.2 4476.7 4479.8 4531.4 4674.5 4676.4 4686.8 4694.3 4745.1 4954.2 4962.4 4964.1 4968.7 5027.2 4618.9 4634.4 4670.4 4670.6 4700.6 4813.9 4817.6 4839.5 4839.7 4882.4 4770.2 4885.9 4911.1 4911.3 4962.1 4813.1 4833.6 4839.1 4849.9 4884.6 4764.0 4768.5 4771.1 4773.3 4846.3 4619.5 4708.1 4710.5 4715.9 4757.3 4812.5 4822.9 4826.8 4829.6 4876.5 4726.8 4739.9 4740.1 4743.2 4790.7 16:26:07 INFO - PROCESS | 25952 | 16:26:07 INFO - PROCESS | 25952 | [#1] ext.html Cycles:180 Average:41128.20 Median:18272.94 stddev:72295.25 (395.6%) stddev-sans-first:72433.94 16:26:07 INFO - PROCESS | 25952 | Values: 576.3 589.3 606.0 621.4 642.2 27444.3 28149.7 34513.5 35448.8 35631.1 37140.0 37686.8 37748.4 37869.4 37903.0 7568.7 7745.0 7748.5 7749.5 7753.3 7687.9 7799.7 7817.0 7820.6 7822.1 7926.0 7993.4 8000.8 8001.7 8002.3 7898.2 7954.5 7968.5 7972.5 7980.2 7768.0 7870.4 7871.7 7879.2 7886.6 37241.1 37434.6 37690.0 37827.4 37863.1 2936.5 2968.4 3003.7 3156.4 3273.2 28880.0 29306.9 29639.1 29644.6 29761.3 3332.4 3368.1 3412.8 3461.6 3480.9 235234.0 235616.0 236861.0 237125.0 237246.8 32739.2 52162.7 52375.5 52438.2 52516.0 31329.7 31419.5 31502.2 31606.0 31620.7 11675.2 11813.5 11880.1 11893.9 11897.3 9611.2 9661.0 9692.3 9692.7 9716.3 7967.6 8135.9 8162.0 8215.8 8237.1 3200.8 3226.5 3240.9 3244.7 3251.3 873.7 946.3 987.8 1000.4 1054.5 28318.0 28495.4 28514.4 28795.3 29095.6 1020.6 1073.8 1103.1 1124.6 1124.6 14771.6 15172.7 15284.2 15336.5 15560.3 341066.0 347459.0 348943.0 349053.0 349164.0 49029.5 49827.3 49839.3 49839.3 49888.0 1065.9 1130.2 1205.4 1259.1 1286.5 25043.9 26104.9 27690.9 28015.4 28096.7 38270.4 38672.0 38792.4 38828.4 38889.2 222845.0 224032.0 224233.0 225104.1 226106.0 22645.4 24945.8 24974.9 26049.6 26087.5 36365.3 36446.6 36928.8 37217.3 37471.6 31435.4 31807.4 31960.5 32060.4 32120.8 31256.8 31855.7 31969.0 32102.7 32132.5 33213.5 33428.0 33709.7 33852.5 34067.3 29533.6 30790.7 30878.2 31077.0 31172.0 23277.3 23845.6 24238.8 24280.6 24496.1 16:26:07 INFO - PROCESS | 25952 | 16:26:07 INFO - PROCESS | 25952 | [#2] jquery.html Cycles:180 Average:23865.86 Median:4646.44 stddev:66956.58 (1441.0%) stddev-sans-first:67121.17 16:26:07 INFO - PROCESS | 25952 | Values: 371.6 376.7 385.0 385.8 388.0 15957.8 16517.2 16836.7 16839.3 16864.1 11184.6 11195.3 11209.0 11212.0 11261.8 4654.1 4759.6 4790.6 4794.0 4864.6 4638.8 4775.0 4775.2 4776.9 4789.1 4738.5 4773.3 4788.0 4954.9 5199.9 5077.2 5153.2 5174.2 5191.1 5222.1 4425.6 4687.0 4699.0 4701.5 4718.7 12163.6 12292.4 12319.1 12458.6 12554.6 1688.3 1778.2 1894.6 1931.3 1987.4 9042.1 9176.4 9261.4 9463.3 9482.9 1684.7 1707.7 1737.2 1743.9 1798.5 65794.0 67884.0 67903.0 68950.0 69948.7 8190.5 8847.0 8913.3 9099.6 10306.8 11695.4 11777.7 11810.8 11869.8 11872.2 6419.8 6619.9 6633.8 6758.2 6798.5 6194.5 6201.4 6248.3 6513.0 6590.8 3823.4 3847.6 3855.5 3902.4 3945.2 1804.3 1883.0 1895.0 1903.2 1943.4 770.5 826.7 834.7 852.5 934.5 15898.4 16676.7 16701.0 16798.9 16946.2 832.1 849.3 860.0 864.2 926.1 8727.5 9233.0 9471.4 9498.8 9734.6 391205.0 396998.0 408702.0 415901.0 416851.0 48804.8 78892.0 80555.6 81270.6 81879.6 881.8 892.9 899.8 907.6 910.0 14691.8 14752.0 14754.0 14824.3 15188.1 32604.7 32879.2 33491.2 33928.8 34006.3 47712.8 48127.5 48187.5 48207.3 48400.3 6801.3 7272.9 7440.4 7978.0 8150.8 11496.2 11564.2 11565.5 11853.6 11941.2 9939.4 10021.9 10199.3 10298.8 10401.8 10291.4 10397.9 10493.5 10736.0 10844.6 10578.1 10778.4 10926.5 11048.9 11100.7 7328.4 7354.9 7390.5 7424.9 7628.3 8685.4 10721.0 10816.9 10853.0 11069.1 16:26:07 INFO - PROCESS | 25952 | 16:26:07 INFO - PROCESS | 25952 | [#3] mootools.html Cycles:180 Average:5240.47 Median:5206.30 stddev:2926.19 (56.2%) stddev-sans-first:2919.08 16:26:07 INFO - PROCESS | 25952 | Values: 1255.9 1382.7 1446.6 1583.6 1816.7 7613.8 7978.8 7985.2 7988.1 7996.5 7741.6 7915.7 7929.3 7943.5 7946.5 1838.6 1907.1 2115.5 2181.6 2215.0 2221.7 2243.7 2244.8 2247.1 2247.2 2174.6 2198.5 2202.9 2205.8 2206.1 1809.5 2059.1 2113.5 2122.4 2149.8 2169.5 2172.7 2194.2 2196.6 2199.4 7720.9 7847.5 7861.5 7866.5 7872.4 4645.3 4803.5 4816.8 4817.7 4846.1 2936.0 2962.6 2997.5 3054.7 3057.5 886.8 888.7 905.0 922.9 928.5 10919.1 10926.3 10934.2 10951.8 11051.0 4259.0 4374.5 4515.3 4540.6 4541.4 9266.5 9274.7 9289.8 9300.3 9322.7 4937.0 4940.4 4951.3 4957.4 4961.1 3709.8 4230.0 4305.7 4318.6 4343.9 3610.5 3658.4 3733.6 3767.5 3772.1 1199.6 1213.5 1214.9 1215.2 1226.2 783.6 881.5 887.7 911.2 921.9 5165.3 5226.1 5254.8 5274.6 5699.3 857.5 861.8 902.0 961.5 963.7 3930.1 3946.8 3949.8 4005.4 4014.9 9552.1 9945.7 10034.1 10082.6 10111.0 9936.1 9942.1 9991.9 9999.1 10018.1 7398.8 7537.7 7546.0 7562.4 7562.5 5186.5 5498.8 5550.9 5569.9 5669.3 8632.6 8727.4 8806.7 8832.6 8977.6 8911.7 9067.6 9238.7 9282.0 9341.3 6034.7 6218.8 6220.8 6648.6 6777.8 6681.2 6936.9 7596.2 7630.9 7636.7 6703.5 6762.7 6809.2 6826.9 6870.5 6460.2 6650.5 6698.9 6736.0 6787.5 6562.8 6570.0 6651.9 6652.3 6653.9 4573.9 4715.8 4740.4 4747.9 4768.2 4835.6 4867.5 4890.6 4917.4 5000.5 16:26:07 INFO - PROCESS | 25952 | 16:26:07 INFO - PROCESS | 25952 | [#4] prototype.html Cycles:180 Average:4344.79 Median:5000.10 stddev:1255.77 (25.1%) stddev-sans-first:1222.17 16:26:07 INFO - PROCESS | 25952 | Values: 306.9 307.2 307.2 314.6 316.9 5015.6 5031.6 5043.5 5050.1 5052.3 4965.9 4974.6 4976.0 4981.4 4984.6 3736.2 3843.2 3850.1 3918.9 3989.0 3926.2 3975.1 3975.4 3976.2 3982.5 3732.5 3937.7 3938.9 3960.4 3963.3 3786.8 3941.7 3952.2 3958.9 3963.9 3501.6 3505.8 3507.8 3508.4 3520.1 4847.8 4850.7 4853.2 4866.3 4878.4 4224.5 4453.2 4458.5 4479.9 4527.0 5250.9 5254.2 5264.7 5267.4 5268.4 3712.3 3716.6 3719.9 3723.1 3728.3 5254.6 5460.0 5541.6 5543.1 5543.7 3790.4 3791.9 3811.1 3813.2 3822.1 3849.9 3860.7 3862.7 3869.5 3869.9 4222.2 4383.9 4396.1 4402.3 4405.7 5196.8 5238.2 5244.2 5251.0 5260.0 1316.5 1338.5 1339.1 1340.5 1342.8 845.9 889.8 891.3 898.9 905.7 4567.4 4574.0 4597.4 4600.6 4609.9 5365.6 5374.0 5379.4 5382.5 5385.9 4480.5 4566.2 4577.5 4577.5 4603.4 2867.4 2878.6 2882.7 2892.4 2905.8 5049.1 5058.1 5065.5 5081.7 5082.2 5266.8 5464.0 5478.9 5489.7 5492.1 5028.3 5062.7 5063.7 5071.6 5072.9 5301.5 5343.9 5387.2 5394.5 5400.1 5156.6 5176.2 5240.3 5266.6 5304.1 5047.2 5049.3 5060.5 5067.3 5070.5 3771.3 3788.6 3809.6 3816.3 3829.0 5122.2 5361.1 5370.4 5371.1 5382.4 5202.1 5210.5 5213.8 5218.7 5226.3 5217.6 5219.0 5222.1 5228.6 5232.6 4922.7 5118.6 5138.5 5141.2 5144.2 5046.1 5148.2 5254.9 5262.4 5271.8 5175.1 5177.8 5213.6 5217.8 5232.2 16:26:07 INFO - PROCESS | 25952 | 16:26:07 INFO - PROCESS | 25952 | [#5] yui.html Cycles:180 Average:12250.90 Median:43150.18 stddev:13511.70 (31.3%) stddev-sans-first:13522.00 16:26:07 INFO - PROCESS | 25952 | Values: 748.9 761.3 761.9 776.4 784.9 11175.6 11446.6 11450.8 11454.8 11456.0 11232.0 11264.2 11280.4 11299.4 11328.2 643.7 786.0 789.5 810.8 820.5 810.2 815.0 816.3 817.1 817.4 859.9 862.8 863.3 865.0 865.5 601.7 628.7 830.6 856.5 858.3 628.9 631.2 633.1 634.0 634.1 11452.8 11485.3 11492.5 11501.4 11574.8 12251.4 12331.7 12724.4 12902.2 13132.6 9626.5 9698.8 10153.4 11073.6 11304.3 3238.7 3263.9 3270.2 3321.9 3347.0 41369.6 44537.8 44717.6 45703.5 45737.5 9844.3 9960.6 9973.6 10190.4 10229.9 16980.8 17004.6 17016.9 17038.7 17208.5 6358.3 6491.3 6491.6 6618.7 6732.0 3722.6 3748.5 3802.0 3841.4 3876.8 2958.9 3047.0 3050.5 3054.1 3060.2 548.4 552.1 556.7 570.8 572.8 488.4 555.0 633.0 635.7 640.9 7382.4 7645.9 7964.4 7972.9 8149.2 520.5 565.2 602.7 609.7 614.5 3731.7 3849.3 3902.9 3926.4 3944.8 46296.5 46311.8 46381.3 46779.0 50128.5 41762.6 46103.0 46393.0 46575.3 46668.3 37232.4 37404.8 38882.4 39003.8 40526.4 8054.6 8193.3 8338.2 8419.2 8507.3 26063.6 26436.5 26741.3 26861.9 26894.7 35257.5 35503.5 38280.0 38555.8 38813.8 9780.7 10172.1 10184.3 10213.2 10378.2 11858.0 11901.3 12040.0 12085.4 12695.6 11042.5 11145.2 11224.6 11670.6 11800.9 10135.2 10305.5 10309.1 10493.5 10555.5 11187.8 11290.4 11358.1 11777.5 11902.4 9024.5 9295.2 9468.9 9470.9 9643.0 9082.9 9227.7 9273.2 9320.9 9423.2 16:26:07 INFO - PROCESS | 25952 | -------- Summary: end -------- 16:26:07 INFO - PROCESS | 25952 | 16:26:07 INFO - TEST-INFO | 25952: exit 0 16:26:07 INFO - TEST-OK | dromaeo_css | took 1118545ms 16:26:07 INFO - TEST-START | kraken 16:26:07 INFO - operating with platform_type : linux_ 16:26:07 INFO - Initialising browser for kraken test... 16:26:07 INFO - TEST-INFO | started process 26131 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUia4XF/profile http://localhost:44621/getInfo.html) 16:26:12 INFO - PROCESS | 26131 | __metrics Screen width/height:1600/1200 16:26:12 INFO - PROCESS | 26131 | colorDepth:24 16:26:12 INFO - PROCESS | 26131 | Browser inner width/height: 1024/697 16:26:12 INFO - PROCESS | 26131 | __metrics 16:26:13 ERROR - PROCESS | 26131 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:26:14 INFO - TEST-INFO | 26131: exit 0 16:26:14 INFO - Browser initialized. 16:26:14 INFO - Running cycle 1/1 for kraken test... 16:26:14 INFO - TEST-INFO | started process 26215 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUia4XF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:26:26 INFO - PROCESS | 26215 | RSS: Main: 154460160 16:26:26 INFO - PROCESS | 26215 | 16:26:29 INFO - PROCESS | 26215 | Cycle 1(1): loaded http://localhost:44621/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44621/tests/kraken/driver.html?testName=audio-beat-detection) 16:26:30 INFO - PROCESS | 26215 | RSS: Main: 210165760 16:26:30 INFO - PROCESS | 26215 | 16:26:32 INFO - PROCESS | 26215 | Cycle 1(1): loaded http://localhost:44621/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44621/tests/kraken/driver.html?testName=audio-dft) 16:26:33 INFO - PROCESS | 26215 | RSS: Main: 194486272 16:26:33 INFO - PROCESS | 26215 | 16:26:36 INFO - PROCESS | 26215 | Cycle 1(1): loaded http://localhost:44621/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44621/tests/kraken/driver.html?testName=audio-fft) 16:26:37 INFO - PROCESS | 26215 | RSS: Main: 266280960 16:26:37 INFO - PROCESS | 26215 | 16:26:39 INFO - PROCESS | 26215 | Cycle 1(1): loaded http://localhost:44621/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44621/tests/kraken/driver.html?testName=audio-oscillator) 16:26:40 INFO - PROCESS | 26215 | RSS: Main: 174157824 16:26:40 INFO - PROCESS | 26215 | 16:26:42 INFO - PROCESS | 26215 | Cycle 1(1): loaded http://localhost:44621/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44621/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:26:42 INFO - PROCESS | 26215 | RSS: Main: 178999296 16:26:42 INFO - PROCESS | 26215 | 16:26:46 INFO - PROCESS | 26215 | Cycle 1(1): loaded http://localhost:44621/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44621/tests/kraken/driver.html?testName=imaging-darkroom) 16:26:46 INFO - PROCESS | 26215 | RSS: Main: 214200320 16:26:46 INFO - PROCESS | 26215 | 16:26:50 INFO - PROCESS | 26215 | Cycle 1(1): loaded http://localhost:44621/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44621/tests/kraken/driver.html?testName=imaging-desaturate) 16:26:50 INFO - PROCESS | 26215 | RSS: Main: 214085632 16:26:50 INFO - PROCESS | 26215 | 16:26:53 INFO - PROCESS | 26215 | Cycle 1(1): loaded http://localhost:44621/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44621/tests/kraken/driver.html?testName=json-parse-financial) 16:26:54 INFO - PROCESS | 26215 | RSS: Main: 215764992 16:26:54 INFO - PROCESS | 26215 | 16:26:55 INFO - PROCESS | 26215 | Cycle 1(1): loaded http://localhost:44621/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44621/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:26:56 INFO - PROCESS | 26215 | RSS: Main: 202178560 16:26:56 INFO - PROCESS | 26215 | 16:26:58 INFO - PROCESS | 26215 | Cycle 1(1): loaded http://localhost:44621/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44621/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:26:58 INFO - PROCESS | 26215 | RSS: Main: 206077952 16:26:58 INFO - PROCESS | 26215 | 16:27:01 INFO - PROCESS | 26215 | Cycle 1(1): loaded http://localhost:44621/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44621/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:27:01 INFO - PROCESS | 26215 | RSS: Main: 219385856 16:27:01 INFO - PROCESS | 26215 | 16:27:04 INFO - PROCESS | 26215 | Cycle 1(1): loaded http://localhost:44621/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44621/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:27:05 INFO - PROCESS | 26215 | RSS: Main: 224178176 16:27:05 INFO - PROCESS | 26215 | 16:27:08 INFO - PROCESS | 26215 | Cycle 1(1): loaded http://localhost:44621/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44621/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:27:08 INFO - PROCESS | 26215 | RSS: Main: 220692480 16:27:08 INFO - PROCESS | 26215 | 16:27:10 INFO - PROCESS | 26215 | Cycle 1(1): loaded http://localhost:44621/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44621/tests/kraken/driver.html?testName=ai-astar) 16:27:10 INFO - PROCESS | 26215 | RSS: Main: 284299264 16:27:10 INFO - PROCESS | 26215 | 16:27:10 INFO - PROCESS | 26215 | __start_tp_report 16:27:10 INFO - PROCESS | 26215 | _x_x_mozilla_page_load 16:27:10 INFO - PROCESS | 26215 | _x_x_mozilla_page_load_details 16:27:10 INFO - PROCESS | 26215 | |i|pagename|runs| 16:27:10 INFO - PROCESS | 26215 | |0;ai-astar;112;114;109;113;112;113;104;112;112;115 16:27:10 INFO - PROCESS | 26215 | |1;audio-beat-detection;165;133;158;184;136;153;154;134;188;142 16:27:10 INFO - PROCESS | 26215 | |2;audio-dft;162;161;161;161;162;162;162;161;161;163 16:27:10 INFO - PROCESS | 26215 | |3;audio-fft;74;77;126;115;74;74;75;124;104;74 16:27:10 INFO - PROCESS | 26215 | |4;audio-oscillator;94;94;148;93;94;93;141;94;93;148 16:27:10 INFO - PROCESS | 26215 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;117;117;117 16:27:10 INFO - PROCESS | 26215 | |6;imaging-darkroom;147;146;147;146;146;147;147;146;146;147 16:27:10 INFO - PROCESS | 26215 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;97 16:27:10 INFO - PROCESS | 26215 | |8;json-parse-financial;64;63;64;64;64;63;65;77;62;61 16:27:10 INFO - PROCESS | 26215 | |9;json-stringify-tinderbox;64;64;64;65;64;64;64;65;65;65 16:27:10 INFO - PROCESS | 26215 | |10;stanford-crypto-aes;88;80;79;80;88;89;81;81;81;81 16:27:10 INFO - PROCESS | 26215 | |11;stanford-crypto-ccm;134;136;139;135;132;138;131;135;163;141 16:27:10 INFO - PROCESS | 26215 | |12;stanford-crypto-pbkdf2;178;178;173;174;175;174;174;180;173;175 16:27:10 INFO - PROCESS | 26215 | |13;stanford-crypto-sha256-iterative;74;74;73;75;74;72;77;71;71;71 16:27:10 INFO - PROCESS | 26215 | __end_tp_report 16:27:10 INFO - PROCESS | 26215 | __start_cc_report 16:27:10 INFO - PROCESS | 26215 | _x_x_mozilla_cycle_collect,1899 16:27:10 INFO - PROCESS | 26215 | __end_cc_report 16:27:10 INFO - PROCESS | 26215 | __startTimestamp1461022030748__endTimestamp 16:27:10 INFO - PROCESS | 26215 | 16:27:10 INFO - PROCESS | 26215 | ------- Summary: start ------- 16:27:10 INFO - PROCESS | 26215 | Number of tests: 14 16:27:10 INFO - PROCESS | 26215 | 16:27:10 INFO - PROCESS | 26215 | [#0] ai-astar Cycles:10 Average:111.60 Median:112.50 stddev:3.10 (2.8%) stddev-sans-first:3.28 16:27:10 INFO - PROCESS | 26215 | Values: 112.0 114.0 109.0 113.0 112.0 113.0 104.0 112.0 112.0 115.0 16:27:10 INFO - PROCESS | 26215 | 16:27:10 INFO - PROCESS | 26215 | [#1] audio-beat-detection Cycles:10 Average:154.70 Median:156.00 stddev:19.71 (12.6%) stddev-sans-first:20.56 16:27:10 INFO - PROCESS | 26215 | Values: 165.0 133.0 158.0 184.0 136.0 153.0 154.0 134.0 188.0 142.0 16:27:10 INFO - PROCESS | 26215 | 16:27:10 INFO - PROCESS | 26215 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.70 (0.4%) stddev-sans-first:0.73 16:27:10 INFO - PROCESS | 26215 | Values: 162.0 161.0 161.0 161.0 162.0 162.0 162.0 161.0 161.0 163.0 16:27:10 INFO - PROCESS | 26215 | 16:27:10 INFO - PROCESS | 26215 | [#3] audio-fft Cycles:10 Average:91.70 Median:74.00 stddev:22.76 (30.8%) stddev-sans-first:23.22 16:27:10 INFO - PROCESS | 26215 | Values: 74.0 77.0 126.0 115.0 74.0 74.0 75.0 124.0 104.0 74.0 16:27:10 INFO - PROCESS | 26215 | 16:27:10 INFO - PROCESS | 26215 | [#4] audio-oscillator Cycles:10 Average:109.20 Median:93.50 stddev:25.24 (27.0%) stddev-sans-first:26.17 16:27:10 INFO - PROCESS | 26215 | Values: 94.0 94.0 148.0 93.0 94.0 93.0 141.0 94.0 93.0 148.0 16:27:10 INFO - PROCESS | 26215 | 16:27:10 INFO - PROCESS | 26215 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 16:27:10 INFO - PROCESS | 26215 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 16:27:10 INFO - PROCESS | 26215 | 16:27:10 INFO - PROCESS | 26215 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 16:27:10 INFO - PROCESS | 26215 | Values: 147.0 146.0 147.0 146.0 146.0 147.0 147.0 146.0 146.0 147.0 16:27:10 INFO - PROCESS | 26215 | 16:27:10 INFO - PROCESS | 26215 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 16:27:10 INFO - PROCESS | 26215 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 97.0 16:27:10 INFO - PROCESS | 26215 | 16:27:10 INFO - PROCESS | 26215 | [#8] json-parse-financial Cycles:10 Average:64.70 Median:64.00 stddev:4.47 (7.0%) stddev-sans-first:4.74 16:27:10 INFO - PROCESS | 26215 | Values: 64.0 63.0 64.0 64.0 64.0 63.0 65.0 77.0 62.0 61.0 16:27:10 INFO - PROCESS | 26215 | 16:27:10 INFO - PROCESS | 26215 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:64.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 16:27:10 INFO - PROCESS | 26215 | Values: 64.0 64.0 64.0 65.0 64.0 64.0 64.0 65.0 65.0 65.0 16:27:10 INFO - PROCESS | 26215 | 16:27:10 INFO - PROCESS | 26215 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:81.00 stddev:3.88 (4.8%) stddev-sans-first:3.63 16:27:10 INFO - PROCESS | 26215 | Values: 88.0 80.0 79.0 80.0 88.0 89.0 81.0 81.0 81.0 81.0 16:27:10 INFO - PROCESS | 26215 | 16:27:10 INFO - PROCESS | 26215 | [#11] stanford-crypto-ccm Cycles:10 Average:138.40 Median:137.00 stddev:9.17 (6.7%) stddev-sans-first:9.58 16:27:10 INFO - PROCESS | 26215 | Values: 134.0 136.0 139.0 135.0 132.0 138.0 131.0 135.0 163.0 141.0 16:27:10 INFO - PROCESS | 26215 | 16:27:10 INFO - PROCESS | 26215 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.40 Median:175.00 stddev:2.41 (1.4%) stddev-sans-first:2.37 16:27:10 INFO - PROCESS | 26215 | Values: 178.0 178.0 173.0 174.0 175.0 174.0 174.0 180.0 173.0 175.0 16:27:10 INFO - PROCESS | 26215 | 16:27:10 INFO - PROCESS | 26215 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.20 Median:74.00 stddev:1.99 (2.7%) stddev-sans-first:2.09 16:27:10 INFO - PROCESS | 26215 | Values: 74.0 74.0 73.0 75.0 74.0 72.0 77.0 71.0 71.0 71.0 16:27:10 INFO - PROCESS | 26215 | -------- Summary: end -------- 16:27:10 INFO - PROCESS | 26215 | 16:27:11 INFO - TEST-INFO | 26215: exit 0 16:27:11 INFO - TEST-OK | kraken | took 64166ms 16:27:11 INFO - SUITE-END | took 1182s 16:27:12 INFO - Completed test suite (00:19:43) 16:27:12 INFO - javascript benchmark 16:27:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2584.5218634552602, 2664.147472808701, 2673.8262012969167, 2679.6650418697664, 2705.161399966011, 4537.8638640840745, 4608.792604332804, 4619.23782575875, 4636.65225108117, 4651.488336283006, 4610.23931051377, 4641.698289611173, 4649.163150632885, 4681.9297710534365, 4708.74101924394, 4228.746275223496, 4278.978605106978, 4311.417958575599, 4342.066455712022, 4399.890002749941, 4312.310030395138, 4340.8697739067875, 4358.324459708734, 4369.672274579403, 4407.360932664762, 4196.874093777207, 4252.447181866338, 4267.167902259061, 4292.141571685675, 4341.717788343748, 4194.580541945811, 4199.475065616798, 4204.831806727758, 4214.494260688737, 4238.173556156551, 4186.832526698929, 4194.056337324108, 4207.684423668237, 4233.026403927114, 4241.681873859442, 4396.120775844844, 4512.345709872083, 4548.704334218299, 4605.516420775837, 4613.008203236321, 4961.0, 4971.0803501352, 4973.850784476435, 4977.502249774993, 5002.52476014778, 4869.220924652074, 4992.201247800371, 4993.176125939216, 4997.475265097149, 5000.62495312853, 4657.673962822604, 4711.2226482629985, 4711.646626503026, 4758.381410416693, 4760.5715485606115, 5097.6941383517105, 5128.076946149654, 5128.820491282787, 5130.12787826063, 5180.792768289301, 4729.196036673774, 4898.53463920927, 4923.458419573844, 4925.088858561177, 4930.975345123252, 4878.658493905464, 4894.290327902434, 4897.167481528078, 4922.483139270396, 4943.382077240345, 4828.758562071883, 4830.3237546743485, 4833.661643684979, 4837.129316722953, 4901.313816065754, 4811.759412029384, 4816.253480710496, 4870.0746858096845, 4909.582685471775, 4984.2025275955675, 4162.646175075092, 4173.061061261192, 4180.268453020709, 4208.810603522848, 4210.221109094828, 3642.307961487309, 3644.927101457956, 3647.7446578739764, 3674.2284120334493, 3688.170161713593, 4185.079282557833, 4220.85227017053, 4222.535521092677, 4233.936490952638, 4264.402983582301, 4966.478519755446, 4972.453030166679, 4990.72551009698, 4994.600431965434, 5009.524095210949, 4280.785960701953, 4283.892902677396, 4284.507281662649, 4303.33298338758, 4338.717983331074, 4336.1978034063795, 4426.203283408953, 4476.686631935799, 4479.7536135512855, 4531.365608814768, 4674.485806561275, 4676.392069031141, 4686.8125274988615, 4694.342792009122, 4745.145873742759, 4954.232094025432, 4962.429320628174, 4964.106460837084, 4968.726720030433, 5027.195648696191, 4618.861434156981, 4634.397528321297, 4670.392848929618, 4670.579647831712, 4700.55344742249, 4813.927791083067, 4817.638677099301, 4839.467658557626, 4839.7096174229655, 4882.414110306786, 4770.212914869007, 4885.877853053702, 4911.115999120193, 4911.312416261655, 4962.082014827269, 4813.061453016629, 4833.589144922721, 4839.056384005226, 4849.927251091307, 4884.5603895649565, 4764.047190561971, 4768.4754676986195, 4771.117343291502, 4773.284007398918, 4846.273059041172, 4619.491855895782, 4708.081924024919, 4710.505396933273, 4715.929261061018, 4757.286407038971, 4812.5187481253, 4822.927656085231, 4826.8069277228515, 4829.589484893683, 4876.487968763229, 4726.763661816826, 4739.857804265877, 4740.051989602162, 4743.193657078236, 4790.7365094920115], "value": 4544.564673416391, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.3170642788297, 589.3428826858053, 605.9515238780898, 621.4375989729293, 642.2453617000027, 27444.313892152706, 28149.718502814965, 34513.48229776552, 35448.82275588618, 35631.10922226946, 37140.0, 37686.811565942204, 37748.43377349335, 37869.431958520574, 37903.0, 7568.659410326521, 7745.0, 7748.496347737379, 7749.496282741604, 7753.340966017895, 7687.923120768804, 7799.688012479494, 7817.022872140982, 7820.608969551499, 7822.100458447266, 7925.9603701981405, 7993.360531157523, 8000.839983200332, 8001.7199398021085, 8002.279794818465, 7898.210178982114, 7954.482958607701, 7968.521888686669, 7972.521648701038, 7980.201979802031, 7767.96116019422, 7870.370370370414, 7871.724489642835, 7879.172686867911, 7886.64510097047, 37241.068973275615, 37434.62565374366, 37690.0, 37827.4325885112, 37863.05342366435, 2936.544835550493, 2968.435997160554, 3003.6695963444004, 3156.4476216662224, 3273.2307907641684, 28880.0, 29306.853465732747, 29639.105978396008, 29644.555331670043, 29761.25596860074, 3332.383509050809, 3368.0569440556683, 3412.8197340052125, 3461.584609846809, 3480.8781692640637, 235234.0, 235616.0, 236861.0, 237125.0, 237246.8137659318, 32739.181520462178, 52162.73918630383, 52375.47624523782, 52438.213426798626, 52516.0, 31329.68670313313, 31419.528707069414, 31502.212444689067, 31606.0, 31620.683793161774, 11675.182737208484, 11813.527458901719, 11880.108991825648, 11893.88106118945, 11897.286162830258, 9611.231101511863, 9661.033896610283, 9692.32153749245, 9692.660756873476, 9716.271279654055, 7967.56178410193, 8135.877961830577, 8162.0, 8215.753527394188, 8237.135100814328, 3200.8239546824684, 3226.451503244454, 3240.902772916816, 3244.724198443159, 3251.349730053999, 873.6680061576687, 946.3091942881734, 987.8107322963607, 1000.4347543637822, 1054.488573042074, 28318.0, 28495.43009139847, 28514.429711405657, 28795.28011799722, 29095.56356654652, 1020.6223697232072, 1073.7906108308805, 1103.051375816797, 1124.5501799280353, 1124.6176300057855, 14771.63070923214, 15172.696546069017, 15284.235788210544, 15336.539903802905, 15560.299786509635, 341066.0, 347459.0, 348943.0, 349053.0, 349164.0, 49029.509704903205, 49827.25259121116, 49839.25241121386, 49839.25241121386, 49888.0, 1065.9040686338267, 1130.1636788776245, 1205.4153735438306, 1259.0997436832708, 1286.5175559165314, 25043.87478062598, 26104.8694756525, 27690.861545692143, 28015.43969120647, 28096.71903281023, 38270.42594361031, 38672.0, 38792.41811372888, 38828.41757373698, 38889.222215556096, 222845.0, 224032.0, 224233.0, 225104.12135575176, 226106.0, 22645.43386415353, 24945.75054249434, 24974.875125624254, 26049.609255861556, 26087.478250435266, 36365.27269454649, 36446.635533645385, 36928.81535592305, 37217.25565488729, 37471.62528374681, 31435.371292574477, 31807.36385272328, 31960.520592191602, 32060.358792824478, 32120.839395802872, 31256.843715781277, 31855.681443185273, 31969.0, 32102.678973209968, 32132.518012230303, 33213.50179747257, 33428.0, 33709.662903370656, 33852.49221261634, 34067.318653627284, 29533.556996645497, 30790.692093078782, 30878.22804429907, 31077.0, 31172.0, 23277.3016809496, 23845.642315364938, 24238.75761242365, 24280.635790462802, 24496.14263500769], "value": 15807.103942334526, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.62280285510195, 376.71746190357226, 384.9826757795899, 385.8167370499012, 387.9592642772509, 15957.760633590491, 16517.174141292933, 16836.66326673469, 16839.32642694291, 16864.072476013815, 11184.608538701146, 11195.328280303187, 11209.0, 11212.04697600705, 11261.831072533898, 4654.0924519718665, 4759.619230461572, 4790.568848803607, 4793.9520604794025, 4864.562189402953, 4638.791254393544, 4775.044991001813, 4775.188218002948, 4776.8566942991765, 4789.0661321042235, 4738.549837765407, 4773.284007398901, 4788.018456216468, 4954.925676114861, 5199.922001169985, 5077.238414237875, 5153.2270159476, 5174.172132458826, 5191.143461328877, 5222.060029194743, 4425.645948324126, 4687.039156972813, 4699.036697477009, 4701.4828368879735, 4718.740469274188, 12163.635090947286, 12292.446839892136, 12319.137660363778, 12458.626241212778, 12554.560590379293, 1688.2571668465835, 1778.2353587957173, 1894.6116046210493, 1931.3433432632971, 1987.3640435060786, 9042.095790420972, 9176.403533770284, 9261.351705380626, 9463.337566370357, 9482.905170948272, 1684.6630673865154, 1707.6840784454791, 1737.1922056243782, 1743.8692098092695, 1798.5413719501573, 65794.0, 67884.0, 67903.0, 68950.0, 69948.65025674838, 8190.467619604707, 8847.0, 8913.331500137516, 9099.636014559343, 10306.793864122676, 11695.415229238504, 11777.705557361134, 11810.763784724257, 11869.821952670716, 11872.228305160137, 6419.775307864203, 6619.867602648016, 6633.834154146089, 6758.155230596176, 6798.456123510107, 6194.5044396448175, 6201.441870231701, 6248.28144763349, 6512.967435162794, 6590.835229119214, 3823.3500304948225, 3847.576766555677, 3855.4602355670227, 3902.35611124167, 3945.1715139820385, 1804.305342443169, 1882.9811701882807, 1894.990525047366, 1903.1626084522766, 1943.4461178564325, 770.460677525723, 826.6569373709843, 834.6744769539885, 852.53110789067, 934.5233930695395, 15898.443554475769, 16676.684931370823, 16700.96912778509, 16798.916005419895, 16946.152692365333, 832.1470492744985, 849.3417601358997, 859.9699010534727, 864.1660797330607, 926.1340646495548, 8727.476351418934, 9232.95383523078, 9471.384360016576, 9498.762530936781, 9734.561944712505, 391205.0, 396998.0, 408702.0, 415901.0, 416851.0, 48804.7559762206, 78892.0, 80555.59722201352, 81270.59364703257, 81879.5906020466, 881.8342151675515, 892.9464232145962, 899.8110396816611, 907.5915837872983, 909.9909000910038, 14691.801614395887, 14752.0, 14754.0, 14824.25878706082, 15188.088714677155, 32604.655809771397, 32879.178020549676, 33491.162720932174, 33928.83035584806, 34006.3198736019, 47712.761436192595, 48127.518724812304, 48187.5181248183, 48207.276890847366, 48400.27399588939, 6801.2858649841055, 7272.927270727225, 7440.404767618686, 7978.0, 8150.796230094295, 11496.195266331277, 11564.248323858923, 11565.537378504765, 11853.585124520945, 11941.223820451643, 9939.353941993748, 10021.899781002097, 10199.28604997643, 10298.845517317395, 10401.791964160826, 10291.382517049002, 10397.948010259901, 10493.527791249564, 10736.0, 10844.566217351534, 10578.100861426865, 10778.353298802096, 10926.453677316262, 11048.889511104786, 11100.666979990614, 7328.413726901942, 7354.926450735638, 7390.519616225143, 7424.925750742424, 7628.275313845176, 8685.435446695945, 10721.0, 10816.891831081903, 10853.0, 11069.059129974043], "value": 7724.669628139197, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1255.9246445213282, 1382.7441923244198, 1446.5804916574193, 1583.5803512069297, 1816.7002444596642, 7613.771586852389, 7978.840423191533, 7985.161558036402, 7988.081370642378, 7996.48022878514, 7741.57421341826, 7915.722949696762, 7929.326007289387, 7943.483673561214, 7946.5232086074875, 1838.6138910828743, 1907.0655378864396, 2115.4605575578207, 2181.6073106840763, 2215.0253888289103, 2221.7000704904794, 2243.6971008913833, 2244.842860999731, 2247.056236380724, 2247.1797793805226, 2174.5650869826018, 2198.461376962646, 2202.878841663708, 2205.8014778669917, 2206.117552978805, 1809.5023868436153, 2059.1145807302855, 2113.5350222950924, 2122.448163477507, 2149.7850214978457, 2169.5443956769095, 2172.728408948881, 2194.1771835561663, 2196.560687862418, 2199.3841724317217, 7720.922790772077, 7847.450678452511, 7861.48900321483, 7866.488678235896, 7872.370210383156, 4645.303204519315, 4803.471618122004, 4816.783244753994, 4817.686850354716, 4846.103470857903, 2935.985320073386, 2962.6296712910885, 2997.5203967365337, 3054.7403470705017, 3057.495513240313, 886.8137691084816, 888.7467071884547, 904.9638014479413, 922.8938672052733, 928.5264515097349, 10919.12646988239, 10926.289791163548, 10934.179936504714, 10951.83572246417, 11051.0, 4258.957410425918, 4374.496932852699, 4515.322701594787, 4540.636749060067, 4541.409616749801, 9266.490343031062, 9274.721758347125, 9289.814203716023, 9300.255979521622, 9322.720318390458, 4936.975315123474, 4940.382452193476, 4951.257311403318, 4957.380327459067, 4961.131801934647, 3709.795961222105, 4230.0, 4305.655547556188, 4318.632916202095, 4343.869683909487, 3610.512580801558, 3658.396364599811, 3733.5519737631657, 3767.472553842464, 3772.1135533149686, 1199.598134624893, 1213.4782043721284, 1214.8785121487958, 1215.197969340231, 1226.2274766896799, 783.647358688581, 881.5151666583354, 887.6759982606302, 911.2345629671108, 921.9308551858503, 5165.251038599457, 5226.085435048927, 5254.842354729364, 5274.630775845731, 5699.287589051369, 857.4897935728231, 861.7587075618836, 902.0, 961.4808003678075, 963.720521048902, 3930.115723962143, 3946.782926939046, 3949.822257998397, 4005.439238506611, 4014.8594799182474, 9552.092551207763, 9945.651902183388, 10034.147097496649, 10082.59669613222, 10111.0, 9936.056074672895, 9942.105210530943, 9991.900080999243, 9999.050090241415, 10018.098371146632, 7398.815029624195, 7537.736179233701, 7546.0, 7562.432817538706, 7562.470627056164, 5186.507281808223, 5498.835034948958, 5550.888982220252, 5569.916451253153, 5669.34802497718, 8632.568371581521, 8727.389082764399, 8806.691765788166, 8832.64669413242, 8977.640894364153, 8911.688090916787, 9067.591958362022, 9238.722838314861, 9282.0, 9341.299402544972, 6034.7284372202475, 6218.844528886814, 6220.813375598739, 6648.6343251119715, 6777.762778302736, 6681.164854393201, 6936.895946560907, 7596.164421913696, 7630.923690763021, 7636.732714354971, 6703.463722902058, 6762.661866906733, 6809.182898052265, 6826.897596536155, 6870.484713646397, 6460.160179176677, 6650.534462587572, 6698.899516507159, 6735.966320168368, 6787.490938179755, 6562.8359291018105, 6569.967150164219, 6651.866962660622, 6652.268250492539, 6653.900191497229, 4573.931391029204, 4715.764211789466, 4740.3837501124635, 4747.928781068355, 4768.237082066853, 4835.637327200404, 4867.464578896389, 4890.633202509897, 4917.385326834145, 5000.474950130184], "value": 4221.355635871656, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.947818870792, 307.1920848169314, 307.2135333546122, 314.6130259780471, 316.892256632745, 5015.598752099832, 5031.622628302874, 5043.546080852722, 5050.141475949088, 5052.267421223925, 4965.900681986358, 4974.6269029822815, 4975.964661556448, 4981.37732783402, 4984.601231901448, 3736.178040831013, 3843.1545060086737, 3850.132685647459, 3918.921621567567, 3988.9601103989025, 3926.155876486555, 3975.1254723960683, 3975.3838155085864, 3976.230577393061, 3982.4623675803687, 3732.5147730795093, 3937.7243592948507, 3938.940915886264, 3960.3663413853787, 3963.324755789845, 3786.8106594670157, 3941.7240793144633, 3952.1898010907694, 3958.940615890764, 3963.8810835674976, 3501.5973163086314, 3505.789652620851, 3507.8424120040327, 3508.3860324443376, 3520.06718219672, 4847.757612119415, 4850.733209673466, 4853.199222128344, 4866.270059491069, 4878.414590249157, 4224.5353011168745, 4453.176162409932, 4458.464984201884, 4479.8800299925015, 4527.0, 5250.9474905250845, 5254.211868219798, 5264.684118952875, 5267.420583735786, 5268.394134674485, 3712.3317802795486, 3716.609755975611, 3719.8698045568276, 3723.087843478338, 3728.3475391806323, 5254.579633629301, 5460.0, 5541.639793413416, 5543.085390910495, 5543.722813859331, 3790.3745881929726, 3791.8672846450795, 3811.1424929390664, 3813.237352529505, 3822.1462590643514, 3849.942250866239, 3860.749051311656, 3862.663088831273, 3869.5163104611925, 3869.941950870739, 4222.155568886174, 4383.9342409863875, 4396.120775844844, 4402.295632698753, 4405.735655860659, 5196.792128314825, 5238.240455133984, 5244.187150991603, 5251.0, 5260.0, 1316.486570237608, 1338.4980632262902, 1339.1161833190047, 1340.477213886585, 1342.7515909556764, 845.8688903220011, 889.8042430665244, 891.3448615267773, 898.9011208767031, 905.6649039855164, 4567.383403240587, 4574.0, 4597.356370108188, 4600.631949444037, 4609.8847528811375, 5365.631763900181, 5374.0, 5379.408265090837, 5382.542483888835, 5385.946140538623, 4480.4623445186135, 4566.246569316092, 4577.496475387705, 4577.496475387705, 4603.424571928509, 2867.4121805029918, 2878.6401699787525, 2882.6829048804616, 2892.363679990399, 2905.78206634499, 5049.141645920203, 5058.114829904752, 5065.544101030851, 5081.74591270435, 5082.237664350303, 5266.8156614519075, 5463.972680136574, 5478.863028424242, 5489.670619762827, 5492.121260598365, 5028.321176641107, 5062.721550314768, 5063.670861393997, 5071.619628527875, 5072.898542029213, 5301.469853014668, 5343.866403339792, 5387.218853266333, 5394.541463975606, 5400.135978243619, 5156.5909702362205, 5176.171812509981, 5240.266362709148, 5266.552343050884, 5304.098303288527, 5047.2429135629945, 5049.31834202378, 5060.49395060491, 5067.290579318825, 5070.4929507049, 3771.283456143324, 3788.6211378861894, 3809.6380843819793, 3816.255830113212, 3828.9617103828605, 5122.231665250242, 5361.142217245222, 5370.409254982027, 5371.0869152244995, 5382.434844341287, 5202.1416466282635, 5210.452902445189, 5213.765380557808, 5218.739063046756, 5226.294450249167, 5217.617331407256, 5219.0, 5222.086134926449, 5228.607854410859, 5232.555232805102, 4922.704637721748, 5118.616103792156, 5138.511841375063, 5141.203113517411, 5144.202648589475, 5046.142155833591, 5148.176291793295, 5254.925868366895, 5262.42113367537, 5271.815486457956, 5175.120229561059, 5177.792888284426, 5213.6350455467755, 5217.834598641522, 5232.241325007776], "value": 3945.373415613243, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [748.9363404110651, 761.299604363985, 761.9276168763968, 776.3866545429107, 784.9372050235982, 11175.552977880876, 11446.599369022086, 11450.770984580304, 11454.770904581903, 11456.0, 11232.0, 11264.211505194618, 11280.435978201078, 11299.378534180616, 11328.207025508218, 643.6717274190173, 785.9921400786005, 789.4828887078972, 810.8013536683521, 820.4953953318695, 810.2140923304415, 815.0382548592659, 816.2979837339883, 817.0807841178674, 817.3869597801648, 859.909709480505, 862.7584276402617, 863.3395452478859, 865.0052439694339, 865.4547634989948, 601.6931365003858, 628.7390732845886, 830.6428235858579, 856.4518708026868, 858.2747578296361, 628.8679377330766, 631.2425089892148, 633.1136409027353, 633.9904901426482, 634.112242859995, 11452.828207576893, 11485.253458525252, 11492.482838272297, 11501.367424791633, 11574.768504629861, 12251.387430628432, 12331.691707707289, 12724.427400766896, 12902.161359511696, 13132.606021819362, 9626.518674066268, 9698.75753106178, 10153.390796552156, 11073.612423565137, 11304.321740695503, 3238.70851623355, 3263.8694452221885, 3270.1824543864036, 3321.9169520761934, 3346.983265083659, 41369.58630413687, 44537.777311113234, 44717.55282447166, 45703.54296457026, 45737.54262457366, 9844.261680374, 9960.601575937026, 9973.551190196458, 10190.388576685422, 10229.851731136396, 16980.830191698173, 17004.574885627957, 17016.914915425343, 17038.74441883373, 17208.483745487654, 6358.332375100548, 6491.285958544557, 6491.610503369813, 6618.7021584028835, 6731.966340168366, 3722.553293604785, 3748.5314335708035, 3802.049487628093, 3841.4429907663234, 3876.7673939563715, 2958.9112326630234, 3046.969530304713, 3050.5119180930947, 3054.129573071664, 3060.219643990768, 548.3693752185019, 552.0862971781708, 556.7383329834971, 570.7574280930588, 572.7651662818308, 488.3529323646183, 555.0203890133917, 632.9872204472807, 635.6662752055208, 640.9230892292954, 7382.409407247407, 7645.923540764632, 7964.402669799788, 7972.920270797218, 8149.225823546753, 520.5055197562331, 565.21435205065, 602.7076867719153, 609.6707777800027, 614.4746241963146, 3731.7014638828828, 3849.287881741887, 3902.941455878164, 3926.371780515104, 3944.822482988215, 46296.537034629895, 46311.768441157576, 46381.30428043582, 46779.0, 50128.498715012385, 41762.58237417587, 46103.0, 46393.0, 46575.30137047947, 46668.29997550039, 37232.44151337732, 37404.81297593495, 38882.416763748566, 39003.80498097491, 40526.39210411846, 8054.5569993650915, 8193.344532437271, 8338.166183381856, 8419.242268195892, 8507.276881465144, 26063.609045864705, 26436.471270574097, 26741.331466713487, 26861.865690672203, 26894.73105268922, 35257.471137932436, 35503.46744798882, 38280.04299892525, 38555.80722096484, 38813.805930970164, 9780.696493542819, 10172.13536849376, 10184.338018028804, 10213.234007449322, 10378.169746420419, 11858.0, 11901.345426001653, 12040.0, 12085.395730213279, 12695.619131426072, 11042.503087361249, 11145.164112691418, 11224.55101795919, 11670.649880503599, 11800.940995294968, 10135.239857010902, 10305.484725763832, 10309.123724483503, 10493.475326233505, 10555.472226388496, 11187.776244475228, 11290.43547822622, 11358.09135269193, 11777.52889884395, 11902.40487975615, 9024.503652299187, 9295.163435290857, 9468.905310946802, 9470.905290947003, 9643.0, 9082.863757043782, 9227.677031303872, 9273.165415112673, 9320.906790932004, 9423.151916327564], "value": 5853.2731341371245, "unit": "score"}], "name": "dromaeo_css", "value": 6149.8946311776845, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 114.0, 109.0, 113.0, 112.0, 113.0, 104.0, 112.0, 112.0, 115.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 133.0, 158.0, 184.0, 136.0, 153.0, 154.0, 134.0, 188.0, 142.0], "value": 154.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 161.0, 162.0, 162.0, 162.0, 161.0, 161.0, 163.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 126.0, 115.0, 74.0, 74.0, 75.0, 124.0, 104.0, 74.0], "value": 91.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 148.0, 93.0, 94.0, 93.0, 141.0, 94.0, 93.0, 148.0], "value": 109.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 147.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 97.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 64.0, 64.0, 63.0, 65.0, 77.0, 62.0, 61.0], "value": 64.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 65.0, 64.0, 64.0, 64.0, 65.0, 65.0, 65.0], "value": 64.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 80.0, 79.0, 80.0, 88.0, 89.0, 81.0, 81.0, 81.0, 81.0], "value": 82.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 136.0, 139.0, 135.0, 132.0, 138.0, 131.0, 135.0, 163.0, 141.0], "value": 138.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 178.0, 173.0, 174.0, 175.0, 174.0, 174.0, 180.0, 173.0, 175.0], "value": 175.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 73.0, 75.0, 74.0, 72.0, 77.0, 71.0, 71.0, 71.0], "value": 73.2, "unit": "score"}], "name": "kraken", "value": 1586.3000000000004, "alertThreshold": 2.0}]} 16:27:12 INFO - Return code: 0 16:27:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:27:12 ERROR - # TBPL SUCCESS # 16:27:12 INFO - Running post-action listener: _resource_record_post_action 16:27:12 INFO - Running post-run listener: _resource_record_post_run 16:27:13 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 527925248; Read time: 8; Write time: 913428 16:27:13 INFO - install - Wall time: 16s; CPU: 17.0%; Read bytes: 0; Write bytes: 233611264; Read time: 0; Write time: 593432 16:27:13 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293715968; Read time: 8; Write time: 319996 16:27:13 INFO - Running post-run listener: _upload_blobber_files 16:27:13 INFO - Blob upload gear active. 16:27:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:27:13 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 16:27:13 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:27:13 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:27:14 INFO - (blobuploader) - INFO - Open directory for files ... 16:27:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:27:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:27:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:27:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:27:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:27:14 INFO - (blobuploader) - INFO - Done attempting. 16:27:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:27:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:27:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:27:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:27:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:27:15 INFO - (blobuploader) - INFO - Done attempting. 16:27:15 INFO - (blobuploader) - INFO - Iteration through files over. 16:27:15 INFO - Return code: 0 16:27:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:27:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:27:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8b048dbac01389a80d164043ddd448db00454d18517daddbfe87e34b97b72ddc1e86241fc3b7b2f10ca924d9ce50e86dadcfb42af25e185901cf085789d9e294", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/73187ddf9f2ac82c0ef89290253175c75c1f764d48859dddfe420923d1c1eb11cbb261dda494b538f70662b3603caa7711bd587ecaf89c6cb8c871c4c20c7cf7"} 16:27:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:27:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:27:15 INFO - Contents: 16:27:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8b048dbac01389a80d164043ddd448db00454d18517daddbfe87e34b97b72ddc1e86241fc3b7b2f10ca924d9ce50e86dadcfb42af25e185901cf085789d9e294", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/73187ddf9f2ac82c0ef89290253175c75c1f764d48859dddfe420923d1c1eb11cbb261dda494b538f70662b3603caa7711bd587ecaf89c6cb8c871c4c20c7cf7"} 16:27:15 INFO - Running post-run listener: copy_logs_to_upload_dir 16:27:15 INFO - Copying logs to upload dir... 16:27:15 INFO - mkdir: /builds/slave/test/build/upload/logs 16:27:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.851678 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-04-18 16:27:15.296829) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 16:27:15.303250) ========= 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=df17445c3590ff7897617a0e00000225-1461020462.471051-1730854258 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-Non-PGO/sha512/8b048dbac01389a80d164043ddd448db00454d18517daddbfe87e34b97b72ddc1e86241fc3b7b2f10ca924d9ce50e86dadcfb42af25e185901cf085789d9e294", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/73187ddf9f2ac82c0ef89290253175c75c1f764d48859dddfe420923d1c1eb11cbb261dda494b538f70662b3603caa7711bd587ecaf89c6cb8c871c4c20c7cf7"} build_url:https://queue.taskcluster.net/v1/task/cmUiJAjeQkqAWz0c_cpDTA/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011372 build_url: 'https://queue.taskcluster.net/v1/task/cmUiJAjeQkqAWz0c_cpDTA/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-Non-PGO/sha512/8b048dbac01389a80d164043ddd448db00454d18517daddbfe87e34b97b72ddc1e86241fc3b7b2f10ca924d9ce50e86dadcfb42af25e185901cf085789d9e294", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/73187ddf9f2ac82c0ef89290253175c75c1f764d48859dddfe420923d1c1eb11cbb261dda494b538f70662b3603caa7711bd587ecaf89c6cb8c871c4c20c7cf7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 16:27:15.332237) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 16:27:15.332972) ========= 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=df17445c3590ff7897617a0e00000225-1461020462.471051-1730854258 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004504 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 16:27:15.417546) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 16:27:15.418282) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 16:27:15.418906) ========= ========= Total master_lag: 0.18 =========