builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-016 starttime: 1461761792.81 results: success (0) buildid: 20160427030215 builduid: 966ba7d5b9da44949d1a6e4313ca1bd1 revision: ab0044bfa1df858919797bcd6a9aef76a668cd4a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 05:56:32.809624) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 05:56:32.810080) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 05:56:32.810361) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 05:56:32.826695) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 05:56:32.827150) ========= 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=00204705a9daa57ed339a427000001b9-1461760749.345133-521570645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-27 05:56:33-- 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% 220M=0s 2016-04-27 05:56:33 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.109134 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 05:56:32.949240) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 05:56:32.949534) ========= 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=00204705a9daa57ed339a427000001b9-1461760749.345133-521570645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019573 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 05:56:32.998573) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 05:56:32.998898) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ab0044bfa1df858919797bcd6a9aef76a668cd4a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev ab0044bfa1df858919797bcd6a9aef76a668cd4a --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=00204705a9daa57ed339a427000001b9-1461760749.345133-521570645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-27 05:56:33,217 truncating revision to first 12 chars 2016-04-27 05:56:33,217 Setting DEBUG logging. 2016-04-27 05:56:33,217 attempt 1/10 2016-04-27 05:56:33,218 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ab0044bfa1df?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-27 05:56:33,468 unpacking tar archive at: mozilla-central-ab0044bfa1df/testing/mozharness/ program finished with exit code 0 elapsedTime=0.550267 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 05:56:33.561951) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 05:56:33.562267) ========= script_repo_revision: ab0044bfa1df858919797bcd6a9aef76a668cd4a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 05:56:33.562704) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 05:56:33.562996) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 05:56:33.571511) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-04-27 05:56:33.571790) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=00204705a9daa57ed339a427000001b9-1461760749.345133-521570645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:56:33 INFO - MultiFileLogger online at 20160427 05:56:33 in /builds/slave/test 05:56:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:56:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:56:33 INFO - {'append_to_log': False, 05:56:33 INFO - 'base_work_dir': '/builds/slave/test', 05:56:33 INFO - 'blob_upload_branch': 'Firefox', 05:56:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:56:33 INFO - 'branch': 'Firefox', 05:56:33 INFO - 'buildbot_json_path': 'buildprops.json', 05:56:33 INFO - 'config_files': ('talos/linux_config.py',), 05:56:33 INFO - 'default_actions': ('clobber', 05:56:33 INFO - 'read-buildbot-config', 05:56:33 INFO - 'download-and-extract', 05:56:33 INFO - 'populate-webroot', 05:56:33 INFO - 'create-virtualenv', 05:56:33 INFO - 'install', 05:56:33 INFO - 'run-tests'), 05:56:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:56:33 INFO - 'download_minidump_stackwalk': True, 05:56:33 INFO - 'download_symbols': 'ondemand', 05:56:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:56:33 INFO - 'tooltool.py': '/tools/tooltool.py', 05:56:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:56:33 INFO - '/tools/misc-python/virtualenv.py')}, 05:56:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:56:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:56:33 INFO - 'installer_path': 'installer.exe', 05:56:33 INFO - 'log_level': 'info', 05:56:33 INFO - 'log_name': 'talos', 05:56:33 INFO - 'log_to_console': True, 05:56:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:56:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:56:33 INFO - 'opt_config_files': (), 05:56:33 INFO - 'pip_index': False, 05:56:33 INFO - 'sps_profile': False, 05:56:33 INFO - 'sps_profile_interval': 0, 05:56:33 INFO - 'suite': 'dromaeojs', 05:56:33 INFO - 'system_bits': '32', 05:56:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:56:33 INFO - 'title': 'talos-linux64-ix-016', 05:56:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:56:33 INFO - 'use_talos_json': True, 05:56:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:56:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:56:33 INFO - 'work_dir': 'build'} 05:56:33 INFO - ##### 05:56:33 INFO - ##### Running clobber step. 05:56:33 INFO - ##### 05:56:33 INFO - Running pre-action listener: _resource_record_pre_action 05:56:33 INFO - Running main action method: clobber 05:56:33 INFO - rmtree: /builds/slave/test/build 05:56:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:56:34 INFO - Running post-action listener: _resource_record_post_action 05:56:34 INFO - ##### 05:56:34 INFO - ##### Running read-buildbot-config step. 05:56:34 INFO - ##### 05:56:34 INFO - Running pre-action listener: _resource_record_pre_action 05:56:34 INFO - Running main action method: read_buildbot_config 05:56:34 INFO - Using buildbot properties: 05:56:34 INFO - { 05:56:34 INFO - "project": "", 05:56:34 INFO - "product": "firefox", 05:56:34 INFO - "script_repo_revision": "production", 05:56:34 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:56:34 INFO - "repository": "", 05:56:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:56:34 INFO - "buildid": "20160427030215", 05:56:34 INFO - "stage_platform": "linux64-pgo", 05:56:34 INFO - "basedir": "/builds/slave/test", 05:56:34 INFO - "nightly_build": "True", 05:56:34 INFO - "buildnumber": 423, 05:56:34 INFO - "slavename": "talos-linux64-ix-016", 05:56:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:56:34 INFO - "platform": "ubuntu64_hw", 05:56:34 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:56:34 INFO - "branch": "mozilla-central", 05:56:34 INFO - "repo_path": "mozilla-central", 05:56:34 INFO - "revision": "ab0044bfa1df858919797bcd6a9aef76a668cd4a", 05:56:34 INFO - "pgo_build": "True", 05:56:34 INFO - "builduid": "966ba7d5b9da44949d1a6e4313ca1bd1", 05:56:34 INFO - "slavebuilddir": "test" 05:56:34 INFO - } 05:56:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/TKZdTZZrQOeT4I2Ou6DOcQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 05:56:34 INFO - Running post-action listener: _resource_record_post_action 05:56:34 INFO - ##### 05:56:34 INFO - ##### Running download-and-extract step. 05:56:34 INFO - ##### 05:56:34 INFO - Running pre-action listener: _resource_record_pre_action 05:56:34 INFO - Running main action method: download_and_extract 05:56:34 INFO - mkdir: /builds/slave/test/build/tests 05:56:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:56:34 INFO - https://queue.taskcluster.net/v1/task/TKZdTZZrQOeT4I2Ou6DOcQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:56:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKZdTZZrQOeT4I2Ou6DOcQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:56:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKZdTZZrQOeT4I2Ou6DOcQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:56:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKZdTZZrQOeT4I2Ou6DOcQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:56:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKZdTZZrQOeT4I2Ou6DOcQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:56:35 INFO - Downloaded 1361 bytes. 05:56:35 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:56:35 INFO - Using the following test package requirements: 05:56:35 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:56:35 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:56:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:56:35 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:56:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:56:35 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:56:35 INFO - u'jsshell-linux-x86_64.zip'], 05:56:35 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:56:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:56:35 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:56:35 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:56:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:56:35 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:56:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:56:35 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:56:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:56:35 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:56:35 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:56:35 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:56:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:56:35 INFO - https://queue.taskcluster.net/v1/task/TKZdTZZrQOeT4I2Ou6DOcQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:56:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKZdTZZrQOeT4I2Ou6DOcQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:56:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKZdTZZrQOeT4I2Ou6DOcQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:56:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKZdTZZrQOeT4I2Ou6DOcQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:56:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKZdTZZrQOeT4I2Ou6DOcQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:56:37 INFO - Downloaded 23866428 bytes. 05:56:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:56:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:56:38 INFO - Return code: 0 05:56:38 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:56:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:56:38 INFO - https://queue.taskcluster.net/v1/task/TKZdTZZrQOeT4I2Ou6DOcQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:56:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKZdTZZrQOeT4I2Ou6DOcQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:56:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKZdTZZrQOeT4I2Ou6DOcQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:56:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKZdTZZrQOeT4I2Ou6DOcQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:56:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKZdTZZrQOeT4I2Ou6DOcQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:56:39 INFO - Downloaded 23866428 bytes. 05:56:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:56:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:56:41 INFO - Return code: 0 05:56: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')]} 05:56:41 INFO - https://queue.taskcluster.net/v1/task/TKZdTZZrQOeT4I2Ou6DOcQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:56:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKZdTZZrQOeT4I2Ou6DOcQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:56:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKZdTZZrQOeT4I2Ou6DOcQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:56:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKZdTZZrQOeT4I2Ou6DOcQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:56:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKZdTZZrQOeT4I2Ou6DOcQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:56:43 INFO - Downloaded 10840145 bytes. 05:56:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:56:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:56:43 INFO - Return code: 0 05:56: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')]} 05:56:43 INFO - https://queue.taskcluster.net/v1/task/TKZdTZZrQOeT4I2Ou6DOcQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:56:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKZdTZZrQOeT4I2Ou6DOcQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:56:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKZdTZZrQOeT4I2Ou6DOcQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:56:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKZdTZZrQOeT4I2Ou6DOcQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:56:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TKZdTZZrQOeT4I2Ou6DOcQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:56:47 INFO - Downloaded 58373832 bytes. 05:56:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TKZdTZZrQOeT4I2Ou6DOcQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:56:47 INFO - mkdir: /builds/slave/test/properties 05:56:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:56:47 INFO - Writing to file /builds/slave/test/properties/build_url 05:56:47 INFO - Contents: 05:56:47 INFO - build_url:https://queue.taskcluster.net/v1/task/TKZdTZZrQOeT4I2Ou6DOcQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:56:47 INFO - Running post-action listener: _resource_record_post_action 05:56:47 INFO - Running post-action listener: set_extra_try_arguments 05:56:47 INFO - ##### 05:56:47 INFO - ##### Running populate-webroot step. 05:56:47 INFO - ##### 05:56:47 INFO - Running pre-action listener: _resource_record_pre_action 05:56:47 INFO - Running main action method: populate_webroot 05:56:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:56:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:56:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:56:47 INFO - '--tppagecycles', 05:56:47 INFO - '7'], 05:56:47 INFO - 'tests': ['tsvgm']}}, 05:56:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:56:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:56:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:56:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:56:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:56:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:56:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:56:47 INFO - 'talos_options': ['--disable-e10s'], 05:56:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:56:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:56:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:56:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:56:47 INFO - 'talos_options': ['--disable-e10s'], 05:56:47 INFO - 'tests': ['damp', 'tps']}, 05:56:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:56:47 INFO - 'tests': ['damp', 'tps']}, 05:56:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:56:47 INFO - 'tests': ['dromaeo_dom']}, 05:56:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:56:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:56:47 INFO - 'tests': ['a11yr', 05:56:47 INFO - 'ts_paint', 05:56:47 INFO - 'tpaint', 05:56:47 INFO - 'sessionrestore', 05:56:47 INFO - 'sessionrestore_no_auto_restore', 05:56:47 INFO - 'tabpaint']}, 05:56:47 INFO - 'other-e10s': {'tests': ['a11yr', 05:56:47 INFO - 'ts_paint', 05:56:47 INFO - 'tpaint', 05:56:47 INFO - 'sessionrestore', 05:56:47 INFO - 'sessionrestore_no_auto_restore', 05:56:47 INFO - 'tabpaint']}, 05:56:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:56:47 INFO - 'ts_paint', 05:56:47 INFO - 'tpaint', 05:56:47 INFO - 'sessionrestore', 05:56:47 INFO - 'sessionrestore_no_auto_restore', 05:56:47 INFO - 'tabpaint']}, 05:56:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:56:47 INFO - 'ts_paint', 05:56:47 INFO - 'tpaint', 05:56:47 INFO - 'sessionrestore', 05:56:47 INFO - 'sessionrestore_no_auto_restore', 05:56:47 INFO - 'tabpaint']}, 05:56:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:56:47 INFO - 'tests': ['a11yr', 05:56:47 INFO - 'ts_paint', 05:56:47 INFO - 'tpaint', 05:56:47 INFO - 'sessionrestore', 05:56:47 INFO - 'sessionrestore_no_auto_restore', 05:56:47 INFO - 'tabpaint']}, 05:56:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:56:47 INFO - 'tests': ['a11yr', 05:56:47 INFO - 'ts_paint', 05:56:47 INFO - 'tpaint', 05:56:47 INFO - 'sessionrestore', 05:56:47 INFO - 'sessionrestore_no_auto_restore', 05:56:47 INFO - 'tabpaint']}, 05:56:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:56:47 INFO - 'tests': ['tsvgx', 05:56:47 INFO - 'tsvgr_opacity', 05:56:47 INFO - 'tart', 05:56:47 INFO - 'tscrollx', 05:56:47 INFO - 'cart']}, 05:56:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:56:47 INFO - 'tsvgr_opacity', 05:56:47 INFO - 'tart', 05:56:47 INFO - 'tscrollx', 05:56:47 INFO - 'cart']}, 05:56:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:56:47 INFO - 'talos_options': ['--disable-e10s'], 05:56:47 INFO - 'tests': ['tp5o']}, 05:56:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:56:47 INFO - 'tests': ['tp5o']}, 05:56:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:56:47 INFO - 'talos_options': ['--disable-e10s', 05:56:47 INFO - '--xperf_path', 05:56:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:56:47 INFO - 'tests': ['tp5n']}, 05:56:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:56:47 INFO - 'talos_options': ['--xperf_path', 05:56:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:56:47 INFO - 'tests': ['tp5n']}}, 05:56:47 INFO - 'talos.zip': {'path': '', 05:56:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:56:47 INFO - Running post-action listener: _resource_record_post_action 05:56:47 INFO - ##### 05:56:47 INFO - ##### Running create-virtualenv step. 05:56:47 INFO - ##### 05:56:47 INFO - Running pre-action listener: _resource_record_pre_action 05:56:47 INFO - Running main action method: create_virtualenv 05:56:47 INFO - Creating virtualenv /builds/slave/test/build/venv 05:56: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 05:56:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:56:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:56:47 INFO - Using real prefix '/usr' 05:56:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:56:48 INFO - Installing distribute.............................................................................................................................................................................................done. 05:56:50 INFO - Installing pip.................done. 05:56:50 INFO - Return code: 0 05:56:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:56: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')]} 05:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56: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')]} 05:56:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56: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 0x7f29d66a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16af9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x173e810>, '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 0x173f710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x173fba0>, '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': '00204705a9daa57ed339a427000001b9-1461760749.345133-521570645', '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 05:56: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 05:56: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 05:56:50 INFO - Using env: {'DISPLAY': ':0', 05:56:50 INFO - 'HOME': '/home/cltbld', 05:56:50 INFO - 'LANG': 'en_US.UTF-8', 05:56:50 INFO - 'LANGUAGE': 'en_US:en', 05:56:50 INFO - 'LOGNAME': 'cltbld', 05:56:50 INFO - 'MAIL': '/var/mail/cltbld', 05:56:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:50 INFO - 'MOZ_NO_REMOTE': '1', 05:56:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:56:50 INFO - 'NO_EM_RESTART': '1', 05:56:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:56:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:50 INFO - 'PWD': '/builds/slave/test', 05:56:50 INFO - 'SHELL': '/bin/bash', 05:56:50 INFO - 'SHLVL': '1', 05:56:50 INFO - 'TERM': 'linux', 05:56:50 INFO - 'TMOUT': '86400', 05:56:50 INFO - 'USER': 'cltbld', 05:56:50 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461760749.345133-521570645', 05:56:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:50 INFO - '_': '/tools/buildbot/bin/python'} 05:56:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56: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 05:56:50 INFO - Cleaning up... 05:56:50 INFO - Return code: 0 05:56:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:56: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')]} 05:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56: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')]} 05:56:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56: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 0x7f29d66a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16af9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x173e810>, '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 0x173f710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x173fba0>, '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': '00204705a9daa57ed339a427000001b9-1461760749.345133-521570645', '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 05:56: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 05:56: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 05:56:50 INFO - Using env: {'DISPLAY': ':0', 05:56:50 INFO - 'HOME': '/home/cltbld', 05:56:50 INFO - 'LANG': 'en_US.UTF-8', 05:56:50 INFO - 'LANGUAGE': 'en_US:en', 05:56:50 INFO - 'LOGNAME': 'cltbld', 05:56:50 INFO - 'MAIL': '/var/mail/cltbld', 05:56:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:50 INFO - 'MOZ_NO_REMOTE': '1', 05:56:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:56:50 INFO - 'NO_EM_RESTART': '1', 05:56:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:56:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:50 INFO - 'PWD': '/builds/slave/test', 05:56:50 INFO - 'SHELL': '/bin/bash', 05:56:50 INFO - 'SHLVL': '1', 05:56:50 INFO - 'TERM': 'linux', 05:56:50 INFO - 'TMOUT': '86400', 05:56:50 INFO - 'USER': 'cltbld', 05:56:50 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461760749.345133-521570645', 05:56:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:50 INFO - '_': '/tools/buildbot/bin/python'} 05:56:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:50 INFO - Downloading/unpacking psutil>=0.7.1 05:56: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 05:56: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 05:56: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 05:56: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 05:56: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 05:56: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 05:56:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:56:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:56:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:56:52 INFO - Installing collected packages: psutil 05:56:52 INFO - Running setup.py install for psutil 05:56:52 INFO - building 'psutil._psutil_linux' extension 05:56: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 05:56: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_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:56:53 INFO - building 'psutil._psutil_posix' extension 05:56: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 05:56: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 05:56:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:56:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:56:53 INFO - Successfully installed psutil 05:56:53 INFO - Cleaning up... 05:56:53 INFO - Return code: 0 05:56:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:56: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')]} 05:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56: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')]} 05:56:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56: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 0x7f29d66a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16af9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x173e810>, '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 0x173f710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x173fba0>, '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': '00204705a9daa57ed339a427000001b9-1461760749.345133-521570645', '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 05:56: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 05:56: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 05:56:53 INFO - Using env: {'DISPLAY': ':0', 05:56:53 INFO - 'HOME': '/home/cltbld', 05:56:53 INFO - 'LANG': 'en_US.UTF-8', 05:56:53 INFO - 'LANGUAGE': 'en_US:en', 05:56:53 INFO - 'LOGNAME': 'cltbld', 05:56:53 INFO - 'MAIL': '/var/mail/cltbld', 05:56:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:53 INFO - 'MOZ_NO_REMOTE': '1', 05:56:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:56:53 INFO - 'NO_EM_RESTART': '1', 05:56:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:56:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:53 INFO - 'PWD': '/builds/slave/test', 05:56:53 INFO - 'SHELL': '/bin/bash', 05:56:53 INFO - 'SHLVL': '1', 05:56:53 INFO - 'TERM': 'linux', 05:56:53 INFO - 'TMOUT': '86400', 05:56:53 INFO - 'USER': 'cltbld', 05:56:53 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461760749.345133-521570645', 05:56:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:53 INFO - '_': '/tools/buildbot/bin/python'} 05:56:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:56: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 05:56: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 05:56: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 05:56: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 05:56: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 05:56: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 05:56:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:56:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:56: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) 05:56:55 INFO - Installing collected packages: mozsystemmonitor 05:56:55 INFO - Running setup.py install for mozsystemmonitor 05:56:55 INFO - Successfully installed mozsystemmonitor 05:56:55 INFO - Cleaning up... 05:56:55 INFO - Return code: 0 05:56:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:56: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')]} 05:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56: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')]} 05:56:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56: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 0x7f29d66a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16af9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x173e810>, '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 0x173f710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x173fba0>, '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': '00204705a9daa57ed339a427000001b9-1461760749.345133-521570645', '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 05:56: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 05:56: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 05:56:55 INFO - Using env: {'DISPLAY': ':0', 05:56:55 INFO - 'HOME': '/home/cltbld', 05:56:55 INFO - 'LANG': 'en_US.UTF-8', 05:56:55 INFO - 'LANGUAGE': 'en_US:en', 05:56:55 INFO - 'LOGNAME': 'cltbld', 05:56:55 INFO - 'MAIL': '/var/mail/cltbld', 05:56:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:55 INFO - 'MOZ_NO_REMOTE': '1', 05:56:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:56:55 INFO - 'NO_EM_RESTART': '1', 05:56:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:56:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:55 INFO - 'PWD': '/builds/slave/test', 05:56:55 INFO - 'SHELL': '/bin/bash', 05:56:55 INFO - 'SHLVL': '1', 05:56:55 INFO - 'TERM': 'linux', 05:56:55 INFO - 'TMOUT': '86400', 05:56:55 INFO - 'USER': 'cltbld', 05:56:55 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461760749.345133-521570645', 05:56:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:55 INFO - '_': '/tools/buildbot/bin/python'} 05:56:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:55 INFO - Downloading/unpacking blobuploader==1.2.4 05:56: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 05:56: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 05:56: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 05:56: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 05:56: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 05:56: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 05:56:57 INFO - Downloading blobuploader-1.2.4.tar.gz 05:56:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:56:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:56: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 05:56: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 05:56: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 05:56: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 05:56: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 05:56: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 05:56:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:56:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:56: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 05:56: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 05:56: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 05:56: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 05:56: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 05:56: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 05:56:58 INFO - Downloading docopt-0.6.1.tar.gz 05:56:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:56:58 INFO - Installing collected packages: blobuploader, requests, docopt 05:56:58 INFO - Running setup.py install for blobuploader 05:56:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:56:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:56:58 INFO - Running setup.py install for requests 05:56:58 INFO - Running setup.py install for docopt 05:56:59 INFO - Successfully installed blobuploader requests docopt 05:56:59 INFO - Cleaning up... 05:56:59 INFO - Return code: 0 05:56:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:56: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')]} 05:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56: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')]} 05:56:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56: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 0x7f29d66a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16af9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x173e810>, '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 0x173f710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x173fba0>, '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': '00204705a9daa57ed339a427000001b9-1461760749.345133-521570645', '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 05:56: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 05:56: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 05:56:59 INFO - Using env: {'DISPLAY': ':0', 05:56:59 INFO - 'HOME': '/home/cltbld', 05:56:59 INFO - 'LANG': 'en_US.UTF-8', 05:56:59 INFO - 'LANGUAGE': 'en_US:en', 05:56:59 INFO - 'LOGNAME': 'cltbld', 05:56:59 INFO - 'MAIL': '/var/mail/cltbld', 05:56:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:59 INFO - 'MOZ_NO_REMOTE': '1', 05:56:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:56:59 INFO - 'NO_EM_RESTART': '1', 05:56:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:56:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:59 INFO - 'PWD': '/builds/slave/test', 05:56:59 INFO - 'SHELL': '/bin/bash', 05:56:59 INFO - 'SHLVL': '1', 05:56:59 INFO - 'TERM': 'linux', 05:56:59 INFO - 'TMOUT': '86400', 05:56:59 INFO - 'USER': 'cltbld', 05:56:59 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461760749.345133-521570645', 05:56:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:59 INFO - '_': '/tools/buildbot/bin/python'} 05:56:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:56:59 INFO - Running setup.py (path:/tmp/pip-dlu8gs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:56:59 INFO - Running setup.py (path:/tmp/pip-UO9eew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:56:59 INFO - Running setup.py (path:/tmp/pip-GL2AQS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:56:59 INFO - Running setup.py (path:/tmp/pip-MPg3Zm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:56:59 INFO - Running setup.py (path:/tmp/pip-Fot00i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:56:59 INFO - Running setup.py (path:/tmp/pip-72RF1t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:56:59 INFO - Running setup.py (path:/tmp/pip-y8g1OC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:56:59 INFO - Running setup.py (path:/tmp/pip-Lz7C9r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:56:59 INFO - Running setup.py (path:/tmp/pip-S3oxF7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:56:59 INFO - Running setup.py (path:/tmp/pip-VNhSDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:57:00 INFO - Running setup.py (path:/tmp/pip-p2cq0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:57:00 INFO - Running setup.py (path:/tmp/pip-YYdgl3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:57:00 INFO - Running setup.py (path:/tmp/pip-YJ9i1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:57:00 INFO - Running setup.py (path:/tmp/pip-BwAtJs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:57:00 INFO - Running setup.py (path:/tmp/pip-kn7sog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:57:00 INFO - Running setup.py (path:/tmp/pip-XEBtOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:57:00 INFO - Running setup.py (path:/tmp/pip-ReRzZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:57:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:57:00 INFO - Running setup.py install for manifestparser 05:57:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:57:00 INFO - Running setup.py install for mozcrash 05:57:00 INFO - Running setup.py install for mozdebug 05:57:00 INFO - Running setup.py install for mozdevice 05:57:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:57:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:57:00 INFO - Running setup.py install for mozfile 05:57:01 INFO - Running setup.py install for mozhttpd 05:57:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:57:01 INFO - Running setup.py install for mozinfo 05:57:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:57:01 INFO - Running setup.py install for mozInstall 05:57:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:57:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:57:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:57:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:57:01 INFO - Running setup.py install for mozleak 05:57:01 INFO - Running setup.py install for mozlog 05:57:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:57:01 INFO - Running setup.py install for moznetwork 05:57:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:57:01 INFO - Running setup.py install for mozprocess 05:57:01 INFO - Running setup.py install for mozprofile 05:57:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:57:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:57:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:57:01 INFO - Running setup.py install for mozrunner 05:57:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:57:02 INFO - Running setup.py install for mozscreenshot 05:57:02 INFO - Running setup.py install for moztest 05:57:02 INFO - Running setup.py install for mozversion 05:57:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:57:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:57:02 INFO - Cleaning up... 05:57:02 INFO - Return code: 0 05:57:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:57: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')]} 05:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57: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')]} 05:57:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57: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 0x7f29d66a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16af9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x173e810>, '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 0x173f710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x173fba0>, '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': '00204705a9daa57ed339a427000001b9-1461760749.345133-521570645', '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 05:57: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 05:57: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 05:57:02 INFO - Using env: {'DISPLAY': ':0', 05:57:02 INFO - 'HOME': '/home/cltbld', 05:57:02 INFO - 'LANG': 'en_US.UTF-8', 05:57:02 INFO - 'LANGUAGE': 'en_US:en', 05:57:02 INFO - 'LOGNAME': 'cltbld', 05:57:02 INFO - 'MAIL': '/var/mail/cltbld', 05:57:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:02 INFO - 'MOZ_NO_REMOTE': '1', 05:57:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:02 INFO - 'NO_EM_RESTART': '1', 05:57:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:02 INFO - 'PWD': '/builds/slave/test', 05:57:02 INFO - 'SHELL': '/bin/bash', 05:57:02 INFO - 'SHLVL': '1', 05:57:02 INFO - 'TERM': 'linux', 05:57:02 INFO - 'TMOUT': '86400', 05:57:02 INFO - 'USER': 'cltbld', 05:57:02 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461760749.345133-521570645', 05:57:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:02 INFO - '_': '/tools/buildbot/bin/python'} 05:57:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:57:02 INFO - Running setup.py (path:/tmp/pip-iUe6kR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:57: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)) 05:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:57:02 INFO - Running setup.py (path:/tmp/pip-r3ZMX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:57: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)) 05:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:57:02 INFO - Running setup.py (path:/tmp/pip-0cjl6A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:57: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)) 05:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:57:02 INFO - Running setup.py (path:/tmp/pip-I8BXIN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:57: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)) 05:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:57:02 INFO - Running setup.py (path:/tmp/pip-W1AmCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:57: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)) 05:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:57:02 INFO - Running setup.py (path:/tmp/pip-NzYgrX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:57: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)) 05:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:57:02 INFO - Running setup.py (path:/tmp/pip-h6jpH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:57:03 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)) 05:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:57:03 INFO - Running setup.py (path:/tmp/pip-q7JZZz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:57: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)) 05:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:57:03 INFO - Running setup.py (path:/tmp/pip-D99mKq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:57: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)) 05:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:57:03 INFO - Running setup.py (path:/tmp/pip-PdScgi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:57: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)) 05:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:57:03 INFO - Running setup.py (path:/tmp/pip-b21KAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:57: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)) 05:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:57:03 INFO - Running setup.py (path:/tmp/pip-MBK0sq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:57: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)) 05:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:57:03 INFO - Running setup.py (path:/tmp/pip-9_aggS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:57: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)) 05:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:57:03 INFO - Running setup.py (path:/tmp/pip-mwkYyt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:57: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)) 05:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:57:03 INFO - Running setup.py (path:/tmp/pip-vzXkwX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:57: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)) 05:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:57:03 INFO - Running setup.py (path:/tmp/pip-6rFHx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:57: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)) 05:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:57:03 INFO - Running setup.py (path:/tmp/pip-_CLOsw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:57: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)) 05:57: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)) 05:57: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)) 05:57: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)) 05:57: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)) 05:57: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)) 05:57:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:57: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 05:57: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 05:57: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 05:57: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 05:57: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 05:57: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 05:57:05 INFO - Downloading blessings-1.6.tar.gz 05:57:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:57:05 INFO - Installing collected packages: blessings 05:57:05 INFO - Running setup.py install for blessings 05:57:05 INFO - Successfully installed blessings 05:57:05 INFO - Cleaning up... 05:57:05 INFO - Return code: 0 05:57:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:57:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:57:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:57:06 INFO - Reading from file tmpfile_stdout 05:57:06 INFO - Current package versions: 05:57:06 INFO - argparse == 1.2.1 05:57:06 INFO - blessings == 1.6 05:57:06 INFO - blobuploader == 1.2.4 05:57:06 INFO - docopt == 0.6.1 05:57:06 INFO - manifestparser == 1.1 05:57:06 INFO - mozInstall == 1.12 05:57:06 INFO - mozcrash == 0.17 05:57:06 INFO - mozdebug == 0.1 05:57:06 INFO - mozdevice == 0.48 05:57:06 INFO - mozfile == 1.2 05:57:06 INFO - mozhttpd == 0.7 05:57:06 INFO - mozinfo == 0.9 05:57:06 INFO - mozleak == 0.1 05:57:06 INFO - mozlog == 3.1 05:57:06 INFO - moznetwork == 0.27 05:57:06 INFO - mozprocess == 0.22 05:57:06 INFO - mozprofile == 0.28 05:57:06 INFO - mozrunner == 6.11 05:57:06 INFO - mozscreenshot == 0.1 05:57:06 INFO - mozsystemmonitor == 0.0 05:57:06 INFO - moztest == 0.7 05:57:06 INFO - mozversion == 1.4 05:57:06 INFO - psutil == 3.1.1 05:57:06 INFO - requests == 1.2.3 05:57:06 INFO - wsgiref == 0.1.2 05:57:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:57: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')]} 05:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57: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')]} 05:57:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57: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 0x7f29d66a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16af9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x173e810>, '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 0x173f710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x173fba0>, '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': '00204705a9daa57ed339a427000001b9-1461760749.345133-521570645', '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 05:57: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 05:57: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 05:57:06 INFO - Using env: {'DISPLAY': ':0', 05:57:06 INFO - 'HOME': '/home/cltbld', 05:57:06 INFO - 'LANG': 'en_US.UTF-8', 05:57:06 INFO - 'LANGUAGE': 'en_US:en', 05:57:06 INFO - 'LOGNAME': 'cltbld', 05:57:06 INFO - 'MAIL': '/var/mail/cltbld', 05:57:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:06 INFO - 'MOZ_NO_REMOTE': '1', 05:57:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:06 INFO - 'NO_EM_RESTART': '1', 05:57:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:06 INFO - 'PWD': '/builds/slave/test', 05:57:06 INFO - 'SHELL': '/bin/bash', 05:57:06 INFO - 'SHLVL': '1', 05:57:06 INFO - 'TERM': 'linux', 05:57:06 INFO - 'TMOUT': '86400', 05:57:06 INFO - 'USER': 'cltbld', 05:57:06 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461760749.345133-521570645', 05:57:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:06 INFO - '_': '/tools/buildbot/bin/python'} 05:57:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57: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)) 05:57: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)) 05:57: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)) 05:57: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)) 05:57: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)) 05:57: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)) 05:57: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)) 05:57: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)) 05:57: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)) 05:57: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)) 05:57: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)) 05:57:06 INFO - Cleaning up... 05:57:06 INFO - Return code: 0 05:57:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:57: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')]} 05:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57: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')]} 05:57:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57: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 0x7f29d66a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16af9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x173e810>, '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 0x173f710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x173fba0>, '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': '00204705a9daa57ed339a427000001b9-1461760749.345133-521570645', '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 05:57: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 05:57: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 05:57:06 INFO - Using env: {'DISPLAY': ':0', 05:57:06 INFO - 'HOME': '/home/cltbld', 05:57:06 INFO - 'LANG': 'en_US.UTF-8', 05:57:06 INFO - 'LANGUAGE': 'en_US:en', 05:57:06 INFO - 'LOGNAME': 'cltbld', 05:57:06 INFO - 'MAIL': '/var/mail/cltbld', 05:57:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:06 INFO - 'MOZ_NO_REMOTE': '1', 05:57:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:06 INFO - 'NO_EM_RESTART': '1', 05:57:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:06 INFO - 'PWD': '/builds/slave/test', 05:57:06 INFO - 'SHELL': '/bin/bash', 05:57:06 INFO - 'SHLVL': '1', 05:57:06 INFO - 'TERM': 'linux', 05:57:06 INFO - 'TMOUT': '86400', 05:57:06 INFO - 'USER': 'cltbld', 05:57:06 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461760749.345133-521570645', 05:57:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:06 INFO - '_': '/tools/buildbot/bin/python'} 05:57:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:06 INFO - Downloading/unpacking jsonschema 05:57: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 05:57: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 05:57: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 05:57: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 05:57: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 05:57: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 05:57:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:57:08 INFO - Downloading/unpacking functools32 (from jsonschema) 05:57: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 05:57: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 05:57: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 05:57: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 05:57: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 05:57: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 05:57:08 INFO - Downloading functools32-3.2.3-2.tar.gz 05:57:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:57:08 INFO - warning: no files found matching '*.txt' 05:57:08 INFO - no previously-included directories found matching 'build' 05:57:08 INFO - no previously-included directories found matching 'dist' 05:57:08 INFO - no previously-included directories found matching '.git*' 05:57:08 INFO - Installing collected packages: jsonschema, functools32 05:57:08 INFO - Running setup.py install for functools32 05:57:08 INFO - warning: no files found matching '*.txt' 05:57:08 INFO - no previously-included directories found matching 'build' 05:57:08 INFO - no previously-included directories found matching 'dist' 05:57:08 INFO - no previously-included directories found matching '.git*' 05:57:08 INFO - Successfully installed jsonschema functools32 05:57:08 INFO - Cleaning up... 05:57:08 INFO - Return code: 0 05:57:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:57: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')]} 05:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57: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')]} 05:57:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57: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 0x7f29d66a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16af9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x173e810>, '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 0x173f710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x173fba0>, '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': '00204705a9daa57ed339a427000001b9-1461760749.345133-521570645', '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 05:57: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 05:57: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 05:57:08 INFO - Using env: {'DISPLAY': ':0', 05:57:08 INFO - 'HOME': '/home/cltbld', 05:57:08 INFO - 'LANG': 'en_US.UTF-8', 05:57:08 INFO - 'LANGUAGE': 'en_US:en', 05:57:08 INFO - 'LOGNAME': 'cltbld', 05:57:08 INFO - 'MAIL': '/var/mail/cltbld', 05:57:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:08 INFO - 'MOZ_NO_REMOTE': '1', 05:57:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:08 INFO - 'NO_EM_RESTART': '1', 05:57:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:08 INFO - 'PWD': '/builds/slave/test', 05:57:08 INFO - 'SHELL': '/bin/bash', 05:57:08 INFO - 'SHLVL': '1', 05:57:08 INFO - 'TERM': 'linux', 05:57:08 INFO - 'TMOUT': '86400', 05:57:08 INFO - 'USER': 'cltbld', 05:57:08 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461760749.345133-521570645', 05:57:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:08 INFO - '_': '/tools/buildbot/bin/python'} 05:57:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:09 INFO - Downloading/unpacking flake8 05:57: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 05:57: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 05:57: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 05:57: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 05:57: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 05:57: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 05:57:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:57:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:57: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 05:57: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 05:57: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 05:57: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 05:57: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 05:57: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 05:57:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:57:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:57: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 05:57: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 05:57: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 05:57: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 05:57: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 05:57: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 05:57:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:57: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 05:57: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 05:57: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 05:57: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 05:57: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 05:57: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 05:57:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:57:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:57:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:57:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:57:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:57:11 INFO - no previously-included directories found matching 'docs/_build' 05:57:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:57:11 INFO - Running setup.py install for pep8 05:57:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:57:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:57:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:57:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:57:11 INFO - no previously-included directories found matching 'docs/_build' 05:57:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:57:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:57:11 INFO - Cleaning up... 05:57:12 INFO - Return code: 0 05:57:12 INFO - Running post-action listener: _resource_record_post_action 05:57:12 INFO - Running post-action listener: _start_resource_monitoring 05:57:12 INFO - Starting resource monitoring. 05:57:12 INFO - ##### 05:57:12 INFO - ##### Running install step. 05:57:12 INFO - ##### 05:57:12 INFO - Running pre-action listener: _resource_record_pre_action 05:57:12 INFO - Running main action method: install 05:57:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:57:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:57:12 INFO - Reading from file tmpfile_stdout 05:57:12 INFO - Detecting whether we're running mozinstall >=1.0... 05:57:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:57:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:57:12 INFO - Reading from file tmpfile_stdout 05:57:12 INFO - Output received: 05:57:12 INFO - Usage: mozinstall [options] installer 05:57:12 INFO - Options: 05:57:12 INFO - -h, --help show this help message and exit 05:57:12 INFO - -d DEST, --destination=DEST 05:57:12 INFO - Directory to install application into. [default: 05:57:12 INFO - "/builds/slave/test"] 05:57:12 INFO - --app=APP Application being installed. [default: firefox] 05:57:12 INFO - mkdir: /builds/slave/test/build/application 05:57:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:57:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:57:28 INFO - Reading from file tmpfile_stdout 05:57:28 INFO - Output received: 05:57:28 INFO - /builds/slave/test/build/application/firefox/firefox 05:57:28 INFO - Running post-action listener: _resource_record_post_action 05:57:28 INFO - ##### 05:57:28 INFO - ##### Running run-tests step. 05:57:28 INFO - ##### 05:57:28 INFO - Running pre-action listener: _resource_record_pre_action 05:57:28 INFO - Running main action method: run_tests 05:57:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:57:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:57:28 INFO - Python 2.7.3 05:57:28 INFO - Return code: 0 05:57:28 INFO - grabbing minidump binary from tooltool 05:57:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:57:28 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 0x173e810>, '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 0x173f710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x173fba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:57:28 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 05:57:28 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 05:57:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:57:28 INFO - Return code: 0 05:57:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:57:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:57:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:57:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:57:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:57:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:57:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:57:29 INFO - Return code: 0 05:57:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TKZdTZZrQOeT4I2Ou6DOcQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 05:57:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TKZdTZZrQOeT4I2Ou6DOcQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --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 05:57:29 INFO - Using env: {'DISPLAY': ':0', 05:57:29 INFO - 'HOME': '/home/cltbld', 05:57:29 INFO - 'LANG': 'en_US.UTF-8', 05:57:29 INFO - 'LANGUAGE': 'en_US:en', 05:57:29 INFO - 'LOGNAME': 'cltbld', 05:57:29 INFO - 'MAIL': '/var/mail/cltbld', 05:57:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:57:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:57:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:29 INFO - 'MOZ_NO_REMOTE': '1', 05:57:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:57:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:57:29 INFO - 'NO_EM_RESTART': '1', 05:57:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:57:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:29 INFO - 'PWD': '/builds/slave/test', 05:57:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:57:29 INFO - 'SHELL': '/bin/bash', 05:57:29 INFO - 'SHLVL': '1', 05:57:29 INFO - 'TERM': 'linux', 05:57:29 INFO - 'TMOUT': '86400', 05:57:29 INFO - 'USER': 'cltbld', 05:57:29 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461760749.345133-521570645', 05:57:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:29 INFO - '_': '/tools/buildbot/bin/python'} 05:57:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TKZdTZZrQOeT4I2Ou6DOcQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 05:57:30 INFO - mozversion application_buildid: 20160427030215 05:57:30 INFO - mozversion application_changeset: ab0044bfa1df858919797bcd6a9aef76a668cd4a 05:57:30 INFO - mozversion application_display_name: Nightly 05:57:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:57:30 INFO - mozversion application_name: Firefox 05:57:30 INFO - mozversion application_remotingname: firefox 05:57:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:57:30 INFO - mozversion application_vendor: Mozilla 05:57:30 INFO - mozversion application_version: 49.0a1 05:57:30 INFO - mozversion platform_buildid: 20160427030215 05:57:30 INFO - mozversion platform_changeset: ab0044bfa1df858919797bcd6a9aef76a668cd4a 05:57:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:57:30 INFO - mozversion platform_version: 49.0a1 05:57:30 INFO - using testdate: 1461761850 05:57:30 INFO - actual date: 1461761850 05:57:30 INFO - starting webserver on 'localhost:57242' 05:57:30 INFO - SUITE-START | Running 2 tests 05:57:30 INFO - TEST-START | dromaeo_css 05:57:30 INFO - operating with platform_type : linux_ 05:57:30 INFO - Initialising browser for dromaeo_css test... 05:57:30 INFO - TEST-INFO | started process 23682 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR3Cg0o/profile http://localhost:57242/getInfo.html) 05:57:34 INFO - PROCESS | 23682 | __metrics Screen width/height:1600/1200 05:57:34 INFO - PROCESS | 23682 | colorDepth:24 05:57:34 INFO - PROCESS | 23682 | Browser inner width/height: 1024/697 05:57:34 INFO - PROCESS | 23682 | __metrics 05:57:35 ERROR - PROCESS | 23682 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:57:36 INFO - TEST-INFO | 23682: exit 0 05:57:36 INFO - Browser initialized. 05:57:36 INFO - Running cycle 1/1 for dromaeo_css test... 05:57:36 INFO - TEST-INFO | started process 23764 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR3Cg0o/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:57:48 INFO - PROCESS | 23764 | RSS: Main: 155004928 05:57:48 INFO - PROCESS | 23764 | 05:58:39 INFO - PROCESS | 23764 | 1461761919201 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] 06:00:46 INFO - PROCESS | 23764 | Cycle 1(1): loaded http://localhost:57242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57242/tests/dromaeo/cssquery-ext.html) 06:00:47 INFO - PROCESS | 23764 | RSS: Main: 259702784 06:00:47 INFO - PROCESS | 23764 | 06:03:50 INFO - PROCESS | 23764 | Cycle 1(1): loaded http://localhost:57242/tests/dromaeo/cssquery-ext.html (next: http://localhost:57242/tests/dromaeo/cssquery-jquery.html) 06:03:50 INFO - PROCESS | 23764 | RSS: Main: 233984000 06:03:50 INFO - PROCESS | 23764 | 06:06:52 INFO - PROCESS | 23764 | Cycle 1(1): loaded http://localhost:57242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57242/tests/dromaeo/cssquery-mootools.html) 06:06:53 INFO - PROCESS | 23764 | RSS: Main: 234762240 06:06:53 INFO - PROCESS | 23764 | 06:09:54 INFO - PROCESS | 23764 | Cycle 1(1): loaded http://localhost:57242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57242/tests/dromaeo/cssquery-prototype.html) 06:09:55 INFO - PROCESS | 23764 | RSS: Main: 234176512 06:09:55 INFO - PROCESS | 23764 | 06:12:58 INFO - PROCESS | 23764 | Cycle 1(1): loaded http://localhost:57242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57242/tests/dromaeo/cssquery-yui.html) 06:12:58 INFO - PROCESS | 23764 | RSS: Main: 223318016 06:12:58 INFO - PROCESS | 23764 | 06:16:01 INFO - PROCESS | 23764 | Cycle 1(1): loaded http://localhost:57242/tests/dromaeo/cssquery-yui.html (next: http://localhost:57242/tests/dromaeo/cssquery-dojo.html) 06:16:01 INFO - PROCESS | 23764 | RSS: Main: 301338624 06:16:01 INFO - PROCESS | 23764 | 06:16:01 INFO - PROCESS | 23764 | __start_tp_report 06:16:01 INFO - PROCESS | 23764 | _x_x_mozilla_page_load 06:16:01 INFO - PROCESS | 23764 | _x_x_mozilla_page_load_details 06:16:01 INFO - PROCESS | 23764 | |i|pagename|runs| 06:16:01 INFO - PROCESS | 23764 | |0;dojo.html;3098.9070327890163;3120.2043478912874;3150.9369812603736;3176.4917613181897;3201.2797120647856;5149.330587023682;5242.344706911636;5260.447652996438;5294.57643388529;5327.334083239595;5309.548688361494;5314.256004159421;5318.547923426504;5407.270018547495;5446.972765136179;4798.040391921612;4827.662063655545;4904.06822703687;4960;4975.502449755032;4904.877378065559;4919.655624106314;4939.58013568847;4942.851714448572;4972.328735620681;4749.548792864673;4757.762111894409;4794.9520504794855;4799.856004319876;4802.303665968432;4803.279508073817;4806.375171227753;4812.614990800727;4826.493218212072;4857.562819346241;4679.321498382749;4759.7620118994255;4774.355462012619;4778.474367819537;4843.975780121112;5133.974330128325;5154.871128221825;5155.072087024334;5155.536001759822;5220.895582088375;5680.204771332017;5681.7727290908315;5707.058335374658;5708.914366284509;5710.486056254916;5595.63628364155;5609.4390560943575;5652.378238393773;5754.165645981351;5756.7121643917635;5254.369475662945;5255.737213139404;5273;5277.788888444457;5302.072137375943;5752.913706294409;5758.827235182951;5759.280089988752;5760.53915686744;5781.53747700183;5407.675539467566;5504.779808807683;5542.0855558832345;5585.804496842591;5607.299087614048;5577.191307260425;5589.636673616202;5591.161325801162;5592.636478628876;5594.384617692051;5571.052921003439;5572.637778544382;5574.331080270394;5581.832545023656;5583.379429602241;5605.1031834907035;5637.6617402955135;5678.943210567924;5715.114157305624;5733.483986441241;4305.354196870432;4307.181635489247;4309.116631090619;4310.224159651293;4344.674149438804;3790.223004284115;3845.9821981999407;3851.306764782366;3894.1627550076305;3907.8046097695;5383.703896285742;5409.891802163935;5410.702411367412;5453.10023846061;5459.590530710213;5546.861328466821;5578.497935185853;5579.972100139474;5581.665100094007;5584.944150558524;5277.9472205278225;5294;5307.920381194285;5315.3621565412395;5375.973120134374;4859.052484765508;4876.561109500162;4878.487758785347;4882.877928051827;4923.113839508923;5858.648481091148;5892.204552385459;5892.528597712173;5897.911531327033;5944.791932282349;5598.188262701804;5686.9715651421475;5702;5706.2011318414625;5787.826365209051;5875.177475153397;5878.088896221093;5878.353381127987;5883.441073098049;5884.911726324023;5587.804426845041;5596.38439771633;5597.048501754793;5598.468145526169;5598.776048957996;5598.440155984369;5657.858553536194;5685.573581981285;5719.084946408721;5720.542356611378;5497.285352904097;5497.890042199214;5509.559235261089;5512.090505066619;5514.531264842373;5441.591880608891;5485.835424937259;5498.5876059294915;5499.560035197094;5549.889002220014;5413.269208656781;5467.835964921059;5497.5601951842955;5526.50261476469;5541.556675466034;5519.475649813261;5530.6128570999645;5553.444655534414;5554.805581804779;5555.138953462219;5432.402435731988;5438.891222175614;5439.673619582838;5439.939211853809;5445.618806683653 06:16:01 INFO - PROCESS | 23764 | |1;ext.html;599.7301214453497;645.956779800622;647.9729628538765;659.3472462262362;668.0246839614163;31793;32400.67599324009;32417.351652966925;37005.25989480209;37991.81004094983;38629.03427414316;39208;39363.21273574527;39423;39509.20981580367;8470.152984701526;8737;8748.431351962134;8750.606222719993;8753.299736021136;8603.096674849145;8737.082606326308;8738.519381434018;8743.256823170039;8743.693970711027;8729.738107856774;8796.516191609491;8801;8806.471611703286;8808.251298639623;8678.913210867873;8743.475391476532;8747.16901894319;8749.956250218707;8753.562321883945;8558.700445484377;8641.265492433151;8657.740267791976;8672.60973256205;8687.391882568223;38901;39303.606963930564;39321.41017884734;39344.80327598372;39517.80241098805;3724.4971928789537;3745.606711295302;3835.9041023974346;3893.9415908761393;4357.237483440385;30065.849670751508;30559.541606875915;30582;30615.234619134477;31928.20179495508;4176.60322269384;4194.874153775391;4228.133232687292;4237.343211802176;4295.978520107379;191789;191836;191947.04026479917;192104;192408;32042.83978580139;55168.44831551633;55822.441775582534;55836.72081639566;55930.720346398004;33495.83252083724;33508.49737253943;33652.663473364955;33674.663253367646;33686.49470257948;13354.265515396746;13518;13567.1859688419;13615.455381784815;13618.250996195105;11166.050885674646;11240.100791936626;11308.434578271053;11316.94341528287;11322.37726925027;8142.959285203655;8217.301529369952;8254.669813207525;8274.462159959583;8363.95818020906;3223.3875563642832;3247.074583743669;3254;3271.116798464401;3303.752218583616;1062.6068354708807;1065.9200559958035;1086.2287775679356;1124.668222874254;1194.743130226988;30506.84746576253;30749.38501229963;31103.567393219182;31270.84364578208;31722.365552688818;1101.9504122314354;1113.3153110836777;1114.7157474843864;1128.1877048525048;1209.5524655877382;15759.821943124936;16401;16644.667106658042;16650.75023874643;16808;368266;369660;369840;371571;373871;53837.73081134569;54221.72889135608;54574.454255457735;54594.18108728372;54697.1795423069;1366.863313668625;1375.938082786277;1382.0740104130257;1384.3770303363526;1405.7118290750373;27593.58609620817;29212.26969325784;30113.247168820955;30118.84940575283;30129;44916.326255105545;44980.77509612562;45342;45379.54620453753;45411.545884540734;230626;231557;232612.0216393511;232725;232888;23007.65488517707;25560.488790224463;25634;25861.224163275132;27348;42974.355384668626;43038.35442468303;44161.77919110384;44492.33261501145;44643.776781115885;37217.241998922225;37814.24371512499;37897.81051094727;38499;38531.2293754129;36752.61761206051;37374;37726;37860.81069594635;38375.23249534938;38028.42957355586;38335.80832095822;38781.224375512895;38801.805990969864;39269;32720;33449.83275083609;34126.31747365089;34272.82863585666;34355.484667729506;25906.611400828624;26130.86934565391;26797.464050719267;26940.32649183786;27133.72866271312 06:16:01 INFO - PROCESS | 23764 | |2;jquery.html;370.14127224838376;378.19255888677674;382.1630628922661;389.09147141424774;391.6670829794677;16996.660066798657;17299.39452119176;18334.174962126704;18449.354272600463;18462.630747385043;16103.758443623326;16419.17904104796;16661.91669041656;16705.415310464137;17462.563435914108;5377.435369286218;5628.212050312939;5635.380108188096;5662.716864156796;5672;4167.499900012002;5161.225816127592;6161.199044124258;6211;6216;5931.495822855062;6044.365341639131;6080.756769729228;6087.178230938811;6114.81655550332;5865.237519122529;5957.046872500379;5958.791442299499;5961.493273071773;5962.224910761595;5067.569256613192;5305.0450918834595;5379.623426360156;5386.973065134688;5389.78440862365;11494.195406321562;11603.303801771921;11667.88332116685;11689.298642081418;11705.941470292593;2183.5960347335795;2223.1774243529835;2301.9884900575557;2310.1567927706433;2315.0855412112123;9092.454282771945;9224.953875230582;9242.260619150451;10925.726856828564;12632.157764503005;1888.9149988250424;1976.9209231630718;1993.5016245938516;1994.38174166009;2053.1787285085934;63592.68203658952;64831.67584162096;66013;66079;67226;10224.233182511342;10264.589416423409;10349.741256468498;10571.735706607242;10869.67390978272;14332.57002289933;14368.784468232985;14389.712205755826;14425.639359015899;14428.278586070865;7377.741779037815;7645.120811106683;7702.691892324357;7792.922070779333;7796.883046754303;7301.780946571611;7365.337119659149;7414.110306763115;7434.25657434263;7493.775186744407;4234.576542345741;4268.914621707549;4331.5451877552405;4502.909941801146;4686.27362758773;1829.9203469952793;1850.7871594766775;1873.6627407066858;1877.4555378940227;1881.1628825172668;1019.7097596540082;1032.7831155457288;1087.49975011494;1113.9610113645983;1122.5509796081633;10278.17774578032;10332.431716255678;17080.316787328367;17465.38871139504;17940.102994850204;425.4936625415807;427.04342273307566;429.5661382004198;434.2400798602446;435.8779541728321;5437.809676661377;5555.166724991283;5605.131204663202;5714.942850571524;5751.1085781703905;501279;510817;511034;523111;524228;59615.40384596185;70430.2956970434;71025.28974710187;75742.31932604966;80587;419.7733224059035;424.581786939864;425.5659227587905;426.3242760225016;427.9358096285582;9866.125436167105;9880.950595246977;9930;10118.342307749972;10175;34725;34830.47754283637;35949.28101438009;36262.63737362593;37118.25763484661;49165;49337.75331123465;49772.25341619806;50735.2389714162;50774.23838642497;7705.653245603849;7927.365810735012;7948.8807667883875;8016.438849280495;8115;10406.947965260428;12415.751684966432;12470.68823279389;12475.376231188586;12726.68183295425;11016.889831101907;11101.668649583355;11195.776084478102;11346.319220846775;11348;11090.279131856403;11442.199046066695;11538;11640.417979101181;11648.592299269485;11658.125640576822;11753.529858805552;11789.528418863149;11799.705007374541;11881;7832.177621349676;7878.133405325524;7956.323712484504;8064.919350806652;8420.536870472182;8212.096669366485;10683.25217234786;11447.771044578894;11584.594539191088;11705.030050624637 06:16:01 INFO - PROCESS | 23764 | |3;mootools.html;1364.8225730655013;1475.8081449411573;1501.8122734658168;1657.5110342448977;1804.1249993753027;7168;7748.651310691018;7917.960410197956;7963.681452741891;7970.880436793438;7735.342495887856;7882.60586970652;7883.132855385903;7884.172161923001;7891.881621775678;2165.079841067544;2197.1870407949;2198.912043518257;2200.515886504966;2202.6695995600708;2140.9785902140934;2151.7310336207975;2177.16179270981;2180;2192.0793266827973;2104.9789502105014;2128.1168315149193;2128.2338358191037;2128.8616239944354;2184.650455927052;2164.3290579920276;2178.934631961036;2183.683365911934;2183.8034576888076;2184.1154332495366;2077.5637116205617;2118.7033815265877;2128.7658357580654;2133.1680644548637;2133.6266153423244;7763.767086987399;7973.32226760726;8007.519548827089;8013.679452821939;8030.036395632503;4549.31760235964;4672.345871577982;4672.906541869178;4679.60223381013;4680.719156850566;2981.4484320400798;2990.2673844908136;3030.863611137504;3041.832699201543;3058.5565093061605;1058.6506452870535;2005.418428655688;2063.8658487198286;2067.1627990663806;2112.714783504223;10639.627613033506;10776.19178561611;10780.784384312348;10795.352278863214;10803.5678572857;3931.1744533647684;4034.8789536313957;4046.5346485154582;4189;4328.761918094535;8663.35024873137;8677.783055423539;8749.256313213447;8751.212390884724;8757.2994160467;4738.976305118453;4748.6438517111355;4755.83354582588;4766.118268120339;4766.165920963817;3982.4623675803973;4065.308897487434;4131.648809851196;4479.014616784302;4490.550944905549;3465.220325426759;3475.548178736748;3525.8413371398346;3553.5558055243096;3554.7689400188906;1051.8737751469719;1055.3984228989557;1057.8783439904355;1058.0424715632364;1063.2610335816687;837.2172019161981;902.6840605788053;979.480875136179;981.6907674082642;986.1322036607739;5721.742521586539;5795.9420405796245;5824;5914.970425147847;6028.517718582503;400.95389030261896;402.90531725044593;402.9858954936563;407.09827731574705;412.15096900385305;3924.1955399143108;4015.297322968469;4070.8575199867864;4123.60825721556;4325.416068830667;9288.7677808054;9815.656452024288;9869.901300986898;9880.505974701236;9906.10845023937;9604.08761167688;9758.46328451942;9760.170385517169;9761.023897610183;9770.120689138012;7249.8550028999125;7265.4187664986675;7394.55632662042;7424.257574242424;7513.2111128330735;5764;5776.566757493289;5863.208466857091;5983.401659834156;5985.25184351956;8963.148500892405;9139.862902056342;9341.626334946526;9353.859692104488;9425.717228483156;9414.57634406467;9414.811703766023;9548.236141108833;9553.426794392359;9563.808723825345;6588.670566471561;7005.614691192033;7188.101487314086;7242.818929526593;7256.492045556972;7839.451238413257;7871.606419678878;7929.286364227247;7936.404769642415;7965.8406831864195;7185.676644550903;7211.206767255702;7346;7435.8141046474275;7457;7148.356647901714;7176.641167941686;7178.5692858428665;7301.233370496234;7318.524295920748;6737;6817.761378351734;6819.420349270367;6824.761133360308;6828.897566536605;4776.641751868554;4853.927191092066;4917.336159618406;5075.238714192753;5122.897542049063;5188.143956247177;5191.506806853343;5258.579313654975;5272;5304.7347632618985 06:16:01 INFO - PROCESS | 23764 | |4;prototype.html;290.8880081168749;304.88414402527036;307.81992534367384;308.8332300557699;310.37769272608415;5200.141976573861;5276.8153114641;5278.445763194862;5278.996990571789;5304.522592966632;4981.427135879375;5073.264376665391;5179.792808287673;5220.243064755608;5243.10867152584;4074;4100.446439730643;4134.64855487284;4136.462259906208;4137.85517506888;4101.912993056842;4109.979450102745;4125;4132.5454200037975;4134.400511925769;3886.8039557649836;4012.1373904610505;4085.508789291902;4102.743491079909;4109;4040.717149799515;4046.898827529306;4061.939070913939;4088.2641124597562;4100.548939616655;3622.2031153146268;3622.836972336225;3634.6547078027547;3636.472711456824;3642.8724994625327;4817.590504807095;5021.799128034874;5079.619028572872;5088.363954505687;5105.591552675777;4552.795124219418;4563.292689633112;4580.427446569179;4590.173768721629;4621.676482646216;5480.890382192374;5484.61607687462;5485.424030476823;5490.313710786152;5491.862703432406;3651.3062518121737;3782.451544526028;3830.7126965477423;3868.3423817951016;3889.9222015559812;5653.293338332708;5654.434556544354;5668.489835914746;5705.942940570582;5714.885702285931;3916.4712763777097;3959.5644479107277;3972;3972.371327755606;3981.223661386002;3924.175923056133;3998.8600398985895;4018.176273863851;4027.2952233359047;4035.5762644922447;4595.540445955377;4600.585947264763;4606.631469482433;4611.1930412177735;4612.884677883079;5529.640573362719;5557.943990641846;5558.360788509373;5562.360328562268;5568.860778480489;1337.7592033434075;1354.0995238166706;1446.088963952724;1460.5837336359086;1462.8317743459424;952.1097773581723;961.6153538584482;963.4989805301204;966.8114717629994;973.634886917406;5601.747921343549;5605.439456054362;5625.971870140705;5646.887062258732;5739.971300143473;5908.911366329508;6033.3061697905305;6036.426539478743;6073.301570319381;6104.511639068864;5560.944390556043;5605.5795815313195;5676.233708449389;5724.914126288109;5726.255586773693;3134.3104517006223;3214.2928555717704;3230.3700778347998;3231.88688395905;3232.9838350808095;6052.909206361908;6146.385361463817;6159.4456498915315;6178.938210617926;6251.718672659741;6067.635941843503;6072.969635151796;6082.361352058058;6093.573449858556;6101.298350689639;6031.366706495754;6174.413430724074;6178.69106544671;6179.640479094592;6190.41191086846;5908.852278693067;5961.165436838759;5980.910286345796;5989.251343582052;5997.310309314485;5873.9720548902915;5907.202527658883;5908.3500814911185;5914.260717410324;5921.940780592139;5930.911036334544;6154.938450615616;6174.567780255339;6181.938180618136;6204.720787564661;4099.1596722672375;4101.097758493127;4105.58944105587;4106.404571337199;4137.544870064351;5466.945330546644;5492.780288788404;5672.9221447924765;6007.579469437097;6015.1278064681255;5546.278983732089;5553.916986187654;5582.469665381782;5601.719914004202;5639.971800140973;5520.641158324696;5536.806211782568;5556.944180605672;5570;5591.692456914909;5225.790968361375;5409.727914276093;5432.728363581726;5504.91742623869;5578.86052848682;5540.556755459635;5564.332280126248;5660.603757736919;5665.376808550974;5666.121751128581;5252.264682944315;5481.753321100639;5519.530839878495;5536.889262214814;5564.860878478071 06:16:01 INFO - PROCESS | 23764 | |5;yui.html;795.3517882925416;804.4208170117515;833.5082301442147;842.2209456252964;842.9578521073945;14611.853881461195;14676.706465870677;14761.261936903138;14809.3335799889;14813.851861481382;12034.33811140387;12892.226466412021;12986.93506532466;13019.73960520789;13027.60917172484;790.4664351562686;824.3775949158407;827.0323721246126;828.1470085811594;828.1635548096406;823.7899335669426;827.611022819277;830.7134038756619;830.8296799156159;831.1605278668528;717.8420747435556;837.1712005114953;864.6584599083359;864.7924498120437;866.7139843851514;854.1714536899229;854.5641722721394;855.0167307596283;855.6192494340021;857.5283594023293;633.1357696743958;633.4267487923437;633.7971849008319;633.8922383194868;633.9936600634027;13045.86954130456;13091.214527128403;13124.868751312555;13135.34323283832;13144.605661830064;13698.109622874581;14558.636034099127;14614.34235459407;14655.780163297559;14693.118412895261;11837.585684501088;11855.288682679067;11868.169228154033;12076.637700868989;12229.510819567207;3895.668868146211;3920.4511368408444;3927.8036098194975;4008.098177909976;4020.336644453662;54469.455305446834;54780;55570;56009.71995140039;56259.43740562542;11020.614278500214;11432.428378581038;11525.654230373102;11555.133364997491;11791.233569817934;20674.276400326216;20694.896525517277;20708;20722.792772072087;20744.688829667568;8243.752687419386;8550.786230344167;8762.386632935633;8844.911550884537;8879.733607991771;4813.374261346003;4884.3161957326;4924.285978533093;4976.5023497649945;5085.618578606619;3185.1877771168206;3266.771326007204;3270.0680306113118;3271.6401195868434;3271.672832716757;509.76550786638563;621.0342916764384;629.9275583307887;632.6615260835431;635;746.171749358212;785.9449838511364;787.8542469643135;803.1647087029424;810.5136917849243;8762.342824288204;8854.822903542023;8875;8956.462612243286;9054.139856713602;738.8928605352194;767.9923200768033;770.2259229474342;777.6345117794627;780.6877249100291;4341.630961368256;4490.663200259994;4491.281394976853;4499.55004499554;4562.110388474282;56918.43081569214;57625;57711;60216;68276.6586167066;53519.464805352225;56362.71818640963;56397.15404268939;57176.71411642998;57949.420505794405;51967.480325196266;52011.219831702554;52305.21542176794;52883.20675189798;53577.732111339974;9058.90941090607;9215.631374745204;9375.203107735646;9397.342186046912;9428.811423771349;32210.83894580512;33252;33571.664283356855;34009.31981360408;34447;45297.54702452933;46537.301940471596;46978.06043879172;47258.29112563246;47443.28835067546;11570.537178512765;11777.646670599896;12178.756424871275;12281.447334869774;12309.630711078682;13233.07368484197;13306.55234783276;13484.393202305724;13771.655708607364;13836.515721949683;12317.199382040497;12515.812262815884;12652;12669.8099528509;12749.745005099661;12453.315067671365;12646.936765316115;12891.548795792101;13030.218186908816;13298.933505332412;12225.083118766306;12268.877311226774;12435.129540932048;12629.684257893627;12860.614181574567;10590.8940910593;10757.408342540923;10760.461976900968;10830.458477075957;11213.66359009231;10504.159667226451;10740.946295268473;10830.133589312994;10848.643919510061;10874.456277186267 06:16:01 INFO - PROCESS | 23764 | __end_tp_report 06:16:01 INFO - PROCESS | 23764 | __start_cc_report 06:16:01 INFO - PROCESS | 23764 | _x_x_mozilla_cycle_collect,775 06:16:01 INFO - PROCESS | 23764 | __end_cc_report 06:16:01 INFO - PROCESS | 23764 | __startTimestamp1461762961314__endTimestamp 06:16:01 INFO - PROCESS | 23764 | 06:16:01 INFO - PROCESS | 23764 | ------- Summary: start ------- 06:16:01 INFO - PROCESS | 23764 | Number of tests: 6 06:16:01 INFO - PROCESS | 23764 | 06:16:01 INFO - PROCESS | 23764 | [#0] dojo.html Cycles:165 Average:5257.25 Median:5459.59 stddev:583.47 (10.7%) stddev-sans-first:560.16 06:16:01 INFO - PROCESS | 23764 | Values: 3098.9 3120.2 3150.9 3176.5 3201.3 5149.3 5242.3 5260.4 5294.6 5327.3 5309.5 5314.3 5318.5 5407.3 5447.0 4798.0 4827.7 4904.1 4960.0 4975.5 4904.9 4919.7 4939.6 4942.9 4972.3 4749.5 4757.8 4795.0 4799.9 4802.3 4803.3 4806.4 4812.6 4826.5 4857.6 4679.3 4759.8 4774.4 4778.5 4844.0 5134.0 5154.9 5155.1 5155.5 5220.9 5680.2 5681.8 5707.1 5708.9 5710.5 5595.6 5609.4 5652.4 5754.2 5756.7 5254.4 5255.7 5273.0 5277.8 5302.1 5752.9 5758.8 5759.3 5760.5 5781.5 5407.7 5504.8 5542.1 5585.8 5607.3 5577.2 5589.6 5591.2 5592.6 5594.4 5571.1 5572.6 5574.3 5581.8 5583.4 5605.1 5637.7 5678.9 5715.1 5733.5 4305.4 4307.2 4309.1 4310.2 4344.7 3790.2 3846.0 3851.3 3894.2 3907.8 5383.7 5409.9 5410.7 5453.1 5459.6 5546.9 5578.5 5580.0 5581.7 5584.9 5277.9 5294.0 5307.9 5315.4 5376.0 4859.1 4876.6 4878.5 4882.9 4923.1 5858.6 5892.2 5892.5 5897.9 5944.8 5598.2 5687.0 5702.0 5706.2 5787.8 5875.2 5878.1 5878.4 5883.4 5884.9 5587.8 5596.4 5597.0 5598.5 5598.8 5598.4 5657.9 5685.6 5719.1 5720.5 5497.3 5497.9 5509.6 5512.1 5514.5 5441.6 5485.8 5498.6 5499.6 5549.9 5413.3 5467.8 5497.6 5526.5 5541.6 5519.5 5530.6 5553.4 5554.8 5555.1 5432.4 5438.9 5439.7 5439.9 5445.6 06:16:01 INFO - PROCESS | 23764 | 06:16:01 INFO - PROCESS | 23764 | [#1] ext.html Cycles:180 Average:42657.91 Median:20470.87 stddev:72528.11 (354.3%) stddev-sans-first:72662.83 06:16:01 INFO - PROCESS | 23764 | Values: 599.7 646.0 648.0 659.3 668.0 31793.0 32400.7 32417.4 37005.3 37991.8 38629.0 39208.0 39363.2 39423.0 39509.2 8470.2 8737.0 8748.4 8750.6 8753.3 8603.1 8737.1 8738.5 8743.3 8743.7 8729.7 8796.5 8801.0 8806.5 8808.3 8678.9 8743.5 8747.2 8750.0 8753.6 8558.7 8641.3 8657.7 8672.6 8687.4 38901.0 39303.6 39321.4 39344.8 39517.8 3724.5 3745.6 3835.9 3893.9 4357.2 30065.8 30559.5 30582.0 30615.2 31928.2 4176.6 4194.9 4228.1 4237.3 4296.0 191789.0 191836.0 191947.0 192104.0 192408.0 32042.8 55168.4 55822.4 55836.7 55930.7 33495.8 33508.5 33652.7 33674.7 33686.5 13354.3 13518.0 13567.2 13615.5 13618.3 11166.1 11240.1 11308.4 11316.9 11322.4 8143.0 8217.3 8254.7 8274.5 8364.0 3223.4 3247.1 3254.0 3271.1 3303.8 1062.6 1065.9 1086.2 1124.7 1194.7 30506.8 30749.4 31103.6 31270.8 31722.4 1102.0 1113.3 1114.7 1128.2 1209.6 15759.8 16401.0 16644.7 16650.8 16808.0 368266.0 369660.0 369840.0 371571.0 373871.0 53837.7 54221.7 54574.5 54594.2 54697.2 1366.9 1375.9 1382.1 1384.4 1405.7 27593.6 29212.3 30113.2 30118.8 30129.0 44916.3 44980.8 45342.0 45379.5 45411.5 230626.0 231557.0 232612.0 232725.0 232888.0 23007.7 25560.5 25634.0 25861.2 27348.0 42974.4 43038.4 44161.8 44492.3 44643.8 37217.2 37814.2 37897.8 38499.0 38531.2 36752.6 37374.0 37726.0 37860.8 38375.2 38028.4 38335.8 38781.2 38801.8 39269.0 32720.0 33449.8 34126.3 34272.8 34355.5 25906.6 26130.9 26797.5 26940.3 27133.7 06:16:01 INFO - PROCESS | 23764 | 06:16:01 INFO - PROCESS | 23764 | [#2] jquery.html Cycles:180 Average:27166.15 Median:2329.58 stddev:84172.61 (3613.2%) stddev-sans-first:84384.69 06:16:01 INFO - PROCESS | 23764 | Values: 370.1 378.2 382.2 389.1 391.7 16996.7 17299.4 18334.2 18449.4 18462.6 16103.8 16419.2 16661.9 16705.4 17462.6 5377.4 5628.2 5635.4 5662.7 5672.0 4167.5 5161.2 6161.2 6211.0 6216.0 5931.5 6044.4 6080.8 6087.2 6114.8 5865.2 5957.0 5958.8 5961.5 5962.2 5067.6 5305.0 5379.6 5387.0 5389.8 11494.2 11603.3 11667.9 11689.3 11705.9 2183.6 2223.2 2302.0 2310.2 2315.1 9092.5 9225.0 9242.3 10925.7 12632.2 1888.9 1976.9 1993.5 1994.4 2053.2 63592.7 64831.7 66013.0 66079.0 67226.0 10224.2 10264.6 10349.7 10571.7 10869.7 14332.6 14368.8 14389.7 14425.6 14428.3 7377.7 7645.1 7702.7 7792.9 7796.9 7301.8 7365.3 7414.1 7434.3 7493.8 4234.6 4268.9 4331.5 4502.9 4686.3 1829.9 1850.8 1873.7 1877.5 1881.2 1019.7 1032.8 1087.5 1114.0 1122.6 10278.2 10332.4 17080.3 17465.4 17940.1 425.5 427.0 429.6 434.2 435.9 5437.8 5555.2 5605.1 5714.9 5751.1 501279.0 510817.0 511034.0 523111.0 524228.0 59615.4 70430.3 71025.3 75742.3 80587.0 419.8 424.6 425.6 426.3 427.9 9866.1 9881.0 9930.0 10118.3 10175.0 34725.0 34830.5 35949.3 36262.6 37118.3 49165.0 49337.8 49772.3 50735.2 50774.2 7705.7 7927.4 7948.9 8016.4 8115.0 10406.9 12415.8 12470.7 12475.4 12726.7 11016.9 11101.7 11195.8 11346.3 11348.0 11090.3 11442.2 11538.0 11640.4 11648.6 11658.1 11753.5 11789.5 11799.7 11881.0 7832.2 7878.1 7956.3 8064.9 8420.5 8212.1 10683.3 11447.8 11584.6 11705.0 06:16:01 INFO - PROCESS | 23764 | 06:16:01 INFO - PROCESS | 23764 | [#3] mootools.html Cycles:180 Average:5329.82 Median:5189.83 stddev:2936.14 (56.6%) stddev-sans-first:2929.25 06:16:01 INFO - PROCESS | 23764 | Values: 1364.8 1475.8 1501.8 1657.5 1804.1 7168.0 7748.7 7918.0 7963.7 7970.9 7735.3 7882.6 7883.1 7884.2 7891.9 2165.1 2197.2 2198.9 2200.5 2202.7 2141.0 2151.7 2177.2 2180.0 2192.1 2105.0 2128.1 2128.2 2128.9 2184.7 2164.3 2178.9 2183.7 2183.8 2184.1 2077.6 2118.7 2128.8 2133.2 2133.6 7763.8 7973.3 8007.5 8013.7 8030.0 4549.3 4672.3 4672.9 4679.6 4680.7 2981.4 2990.3 3030.9 3041.8 3058.6 1058.7 2005.4 2063.9 2067.2 2112.7 10639.6 10776.2 10780.8 10795.4 10803.6 3931.2 4034.9 4046.5 4189.0 4328.8 8663.4 8677.8 8749.3 8751.2 8757.3 4739.0 4748.6 4755.8 4766.1 4766.2 3982.5 4065.3 4131.6 4479.0 4490.6 3465.2 3475.5 3525.8 3553.6 3554.8 1051.9 1055.4 1057.9 1058.0 1063.3 837.2 902.7 979.5 981.7 986.1 5721.7 5795.9 5824.0 5915.0 6028.5 401.0 402.9 403.0 407.1 412.2 3924.2 4015.3 4070.9 4123.6 4325.4 9288.8 9815.7 9869.9 9880.5 9906.1 9604.1 9758.5 9760.2 9761.0 9770.1 7249.9 7265.4 7394.6 7424.3 7513.2 5764.0 5776.6 5863.2 5983.4 5985.3 8963.1 9139.9 9341.6 9353.9 9425.7 9414.6 9414.8 9548.2 9553.4 9563.8 6588.7 7005.6 7188.1 7242.8 7256.5 7839.5 7871.6 7929.3 7936.4 7965.8 7185.7 7211.2 7346.0 7435.8 7457.0 7148.4 7176.6 7178.6 7301.2 7318.5 6737.0 6817.8 6819.4 6824.8 6828.9 4776.6 4853.9 4917.3 5075.2 5122.9 5188.1 5191.5 5258.6 5272.0 5304.7 06:16:01 INFO - PROCESS | 23764 | 06:16:01 INFO - PROCESS | 23764 | [#4] prototype.html Cycles:180 Average:4727.78 Median:5481.32 stddev:1434.06 (26.2%) stddev-sans-first:1398.88 06:16:01 INFO - PROCESS | 23764 | Values: 290.9 304.9 307.8 308.8 310.4 5200.1 5276.8 5278.4 5279.0 5304.5 4981.4 5073.3 5179.8 5220.2 5243.1 4074.0 4100.4 4134.6 4136.5 4137.9 4101.9 4110.0 4125.0 4132.5 4134.4 3886.8 4012.1 4085.5 4102.7 4109.0 4040.7 4046.9 4061.9 4088.3 4100.5 3622.2 3622.8 3634.7 3636.5 3642.9 4817.6 5021.8 5079.6 5088.4 5105.6 4552.8 4563.3 4580.4 4590.2 4621.7 5480.9 5484.6 5485.4 5490.3 5491.9 3651.3 3782.5 3830.7 3868.3 3889.9 5653.3 5654.4 5668.5 5705.9 5714.9 3916.5 3959.6 3972.0 3972.4 3981.2 3924.2 3998.9 4018.2 4027.3 4035.6 4595.5 4600.6 4606.6 4611.2 4612.9 5529.6 5557.9 5558.4 5562.4 5568.9 1337.8 1354.1 1446.1 1460.6 1462.8 952.1 961.6 963.5 966.8 973.6 5601.7 5605.4 5626.0 5646.9 5740.0 5908.9 6033.3 6036.4 6073.3 6104.5 5560.9 5605.6 5676.2 5724.9 5726.3 3134.3 3214.3 3230.4 3231.9 3233.0 6052.9 6146.4 6159.4 6178.9 6251.7 6067.6 6073.0 6082.4 6093.6 6101.3 6031.4 6174.4 6178.7 6179.6 6190.4 5908.9 5961.2 5980.9 5989.3 5997.3 5874.0 5907.2 5908.4 5914.3 5921.9 5930.9 6154.9 6174.6 6181.9 6204.7 4099.2 4101.1 4105.6 4106.4 4137.5 5466.9 5492.8 5672.9 6007.6 6015.1 5546.3 5553.9 5582.5 5601.7 5640.0 5520.6 5536.8 5556.9 5570.0 5591.7 5225.8 5409.7 5432.7 5504.9 5578.9 5540.6 5564.3 5660.6 5665.4 5666.1 5252.3 5481.8 5519.5 5536.9 5564.9 06:16:01 INFO - PROCESS | 23764 | 06:16:01 INFO - PROCESS | 23764 | [#5] yui.html Cycles:180 Average:14981.07 Median:25549.71 stddev:17277.20 (67.6%) stddev-sans-first:17292.82 06:16:01 INFO - PROCESS | 23764 | Values: 795.4 804.4 833.5 842.2 843.0 14611.9 14676.7 14761.3 14809.3 14813.9 12034.3 12892.2 12986.9 13019.7 13027.6 790.5 824.4 827.0 828.1 828.2 823.8 827.6 830.7 830.8 831.2 717.8 837.2 864.7 864.8 866.7 854.2 854.6 855.0 855.6 857.5 633.1 633.4 633.8 633.9 634.0 13045.9 13091.2 13124.9 13135.3 13144.6 13698.1 14558.6 14614.3 14655.8 14693.1 11837.6 11855.3 11868.2 12076.6 12229.5 3895.7 3920.5 3927.8 4008.1 4020.3 54469.5 54780.0 55570.0 56009.7 56259.4 11020.6 11432.4 11525.7 11555.1 11791.2 20674.3 20694.9 20708.0 20722.8 20744.7 8243.8 8550.8 8762.4 8844.9 8879.7 4813.4 4884.3 4924.3 4976.5 5085.6 3185.2 3266.8 3270.1 3271.6 3271.7 509.8 621.0 629.9 632.7 635.0 746.2 785.9 787.9 803.2 810.5 8762.3 8854.8 8875.0 8956.5 9054.1 738.9 768.0 770.2 777.6 780.7 4341.6 4490.7 4491.3 4499.6 4562.1 56918.4 57625.0 57711.0 60216.0 68276.7 53519.5 56362.7 56397.2 57176.7 57949.4 51967.5 52011.2 52305.2 52883.2 53577.7 9058.9 9215.6 9375.2 9397.3 9428.8 32210.8 33252.0 33571.7 34009.3 34447.0 45297.5 46537.3 46978.1 47258.3 47443.3 11570.5 11777.6 12178.8 12281.4 12309.6 13233.1 13306.6 13484.4 13771.7 13836.5 12317.2 12515.8 12652.0 12669.8 12749.7 12453.3 12646.9 12891.5 13030.2 13298.9 12225.1 12268.9 12435.1 12629.7 12860.6 10590.9 10757.4 10760.5 10830.5 11213.7 10504.2 10740.9 10830.1 10848.6 10874.5 06:16:01 INFO - PROCESS | 23764 | -------- Summary: end -------- 06:16:01 INFO - PROCESS | 23764 | 06:16:02 INFO - TEST-INFO | 23764: exit 0 06:16:02 INFO - TEST-OK | dromaeo_css | took 1112002ms 06:16:02 INFO - TEST-START | kraken 06:16:02 INFO - operating with platform_type : linux_ 06:16:02 INFO - Initialising browser for kraken test... 06:16:02 INFO - TEST-INFO | started process 23941 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSdKWCY/profile http://localhost:57242/getInfo.html) 06:16:06 INFO - PROCESS | 23941 | __metrics Screen width/height:1600/1200 06:16:06 INFO - PROCESS | 23941 | colorDepth:24 06:16:06 INFO - PROCESS | 23941 | Browser inner width/height: 1024/697 06:16:06 INFO - PROCESS | 23941 | __metrics 06:16:07 ERROR - PROCESS | 23941 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:16:07 INFO - TEST-INFO | 23941: exit 0 06:16:07 INFO - Browser initialized. 06:16:07 INFO - Running cycle 1/1 for kraken test... 06:16:07 INFO - TEST-INFO | started process 24023 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSdKWCY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:16:19 INFO - PROCESS | 24023 | RSS: Main: 154804224 06:16:19 INFO - PROCESS | 24023 | 06:16:22 INFO - PROCESS | 24023 | Cycle 1(1): loaded http://localhost:57242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57242/tests/kraken/driver.html?testName=audio-beat-detection) 06:16:23 INFO - PROCESS | 24023 | RSS: Main: 209899520 06:16:23 INFO - PROCESS | 24023 | 06:16:25 INFO - PROCESS | 24023 | Cycle 1(1): loaded http://localhost:57242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57242/tests/kraken/driver.html?testName=audio-dft) 06:16:26 INFO - PROCESS | 24023 | RSS: Main: 195506176 06:16:26 INFO - PROCESS | 24023 | 06:16:29 INFO - PROCESS | 24023 | Cycle 1(1): loaded http://localhost:57242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57242/tests/kraken/driver.html?testName=audio-fft) 06:16:30 INFO - PROCESS | 24023 | RSS: Main: 265277440 06:16:30 INFO - PROCESS | 24023 | 06:16:32 INFO - PROCESS | 24023 | Cycle 1(1): loaded http://localhost:57242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57242/tests/kraken/driver.html?testName=audio-oscillator) 06:16:32 INFO - PROCESS | 24023 | RSS: Main: 174510080 06:16:32 INFO - PROCESS | 24023 | 06:16:35 INFO - PROCESS | 24023 | Cycle 1(1): loaded http://localhost:57242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:16:35 INFO - PROCESS | 24023 | RSS: Main: 178700288 06:16:35 INFO - PROCESS | 24023 | 06:16:38 INFO - PROCESS | 24023 | Cycle 1(1): loaded http://localhost:57242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57242/tests/kraken/driver.html?testName=imaging-darkroom) 06:16:39 INFO - PROCESS | 24023 | RSS: Main: 214491136 06:16:39 INFO - PROCESS | 24023 | 06:16:42 INFO - PROCESS | 24023 | Cycle 1(1): loaded http://localhost:57242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57242/tests/kraken/driver.html?testName=imaging-desaturate) 06:16:43 INFO - PROCESS | 24023 | RSS: Main: 214175744 06:16:43 INFO - PROCESS | 24023 | 06:16:45 INFO - PROCESS | 24023 | Cycle 1(1): loaded http://localhost:57242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57242/tests/kraken/driver.html?testName=json-parse-financial) 06:16:46 INFO - PROCESS | 24023 | RSS: Main: 215285760 06:16:46 INFO - PROCESS | 24023 | 06:16:48 INFO - PROCESS | 24023 | Cycle 1(1): loaded http://localhost:57242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:16:48 INFO - PROCESS | 24023 | RSS: Main: 205885440 06:16:48 INFO - PROCESS | 24023 | 06:16:50 INFO - PROCESS | 24023 | Cycle 1(1): loaded http://localhost:57242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57242/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:16:50 INFO - PROCESS | 24023 | RSS: Main: 202924032 06:16:50 INFO - PROCESS | 24023 | 06:16:52 INFO - PROCESS | 24023 | Cycle 1(1): loaded http://localhost:57242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:16:53 INFO - PROCESS | 24023 | RSS: Main: 216428544 06:16:53 INFO - PROCESS | 24023 | 06:16:56 INFO - PROCESS | 24023 | Cycle 1(1): loaded http://localhost:57242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:16:56 INFO - PROCESS | 24023 | RSS: Main: 225267712 06:16:56 INFO - PROCESS | 24023 | 06:16:59 INFO - PROCESS | 24023 | Cycle 1(1): loaded http://localhost:57242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:17:00 INFO - PROCESS | 24023 | RSS: Main: 221028352 06:17:00 INFO - PROCESS | 24023 | 06:17:02 INFO - PROCESS | 24023 | Cycle 1(1): loaded http://localhost:57242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57242/tests/kraken/driver.html?testName=ai-astar) 06:17:02 INFO - PROCESS | 24023 | RSS: Main: 283901952 06:17:02 INFO - PROCESS | 24023 | 06:17:02 INFO - PROCESS | 24023 | __start_tp_report 06:17:02 INFO - PROCESS | 24023 | _x_x_mozilla_page_load 06:17:02 INFO - PROCESS | 24023 | _x_x_mozilla_page_load_details 06:17:02 INFO - PROCESS | 24023 | |i|pagename|runs| 06:17:02 INFO - PROCESS | 24023 | |0;ai-astar;109;111;107;111;111;112;101;109;110;110 06:17:02 INFO - PROCESS | 24023 | |1;audio-beat-detection;166;129;157;191;130;155;159;135;191;133 06:17:02 INFO - PROCESS | 24023 | |2;audio-dft;161;161;160;161;160;160;160;160;160;162 06:17:02 INFO - PROCESS | 24023 | |3;audio-fft;73;75;119;111;76;72;72;129;108;72 06:17:02 INFO - PROCESS | 24023 | |4;audio-oscillator;93;93;160;93;93;95;157;93;93;144 06:17:02 INFO - PROCESS | 24023 | |5;imaging-gaussian-blur;117;118;118;117;117;117;116;117;116;116 06:17:02 INFO - PROCESS | 24023 | |6;imaging-darkroom;146;146;146;145;145;145;145;145;147;147 06:17:02 INFO - PROCESS | 24023 | |7;imaging-desaturate;94;94;94;95;95;95;95;95;95;95 06:17:02 INFO - PROCESS | 24023 | |8;json-parse-financial;58;59;58;58;59;57;59;71;56;56 06:17:02 INFO - PROCESS | 24023 | |9;json-stringify-tinderbox;60;61;62;61;62;61;61;62;63;61 06:17:02 INFO - PROCESS | 24023 | |10;stanford-crypto-aes;76;75;75;76;76;76;78;78;79;79 06:17:02 INFO - PROCESS | 24023 | |11;stanford-crypto-ccm;130;126;137;126;131;122;124;124;164;128 06:17:02 INFO - PROCESS | 24023 | |12;stanford-crypto-pbkdf2;198;198;201;197;200;201;197;208;200;201 06:17:02 INFO - PROCESS | 24023 | |13;stanford-crypto-sha256-iterative;66;71;68;71;70;70;69;70;71;74 06:17:02 INFO - PROCESS | 24023 | __end_tp_report 06:17:02 INFO - PROCESS | 24023 | __start_cc_report 06:17:02 INFO - PROCESS | 24023 | _x_x_mozilla_cycle_collect,1620 06:17:02 INFO - PROCESS | 24023 | __end_cc_report 06:17:02 INFO - PROCESS | 24023 | __startTimestamp1461763022525__endTimestamp 06:17:02 INFO - PROCESS | 24023 | 06:17:02 INFO - PROCESS | 24023 | ------- Summary: start ------- 06:17:02 INFO - PROCESS | 24023 | Number of tests: 14 06:17:02 INFO - PROCESS | 24023 | 06:17:02 INFO - PROCESS | 24023 | [#0] ai-astar Cycles:10 Average:109.10 Median:110.50 stddev:3.18 (2.9%) stddev-sans-first:3.37 06:17:02 INFO - PROCESS | 24023 | Values: 109.0 111.0 107.0 111.0 111.0 112.0 101.0 109.0 110.0 110.0 06:17:02 INFO - PROCESS | 24023 | 06:17:02 INFO - PROCESS | 24023 | [#1] audio-beat-detection Cycles:10 Average:154.60 Median:158.00 stddev:23.37 (14.8%) stddev-sans-first:24.42 06:17:02 INFO - PROCESS | 24023 | Values: 166.0 129.0 157.0 191.0 130.0 155.0 159.0 135.0 191.0 133.0 06:17:02 INFO - PROCESS | 24023 | 06:17:02 INFO - PROCESS | 24023 | [#2] audio-dft Cycles:10 Average:160.50 Median:160.50 stddev:0.71 (0.4%) stddev-sans-first:0.73 06:17:02 INFO - PROCESS | 24023 | Values: 161.0 161.0 160.0 161.0 160.0 160.0 160.0 160.0 160.0 162.0 06:17:02 INFO - PROCESS | 24023 | 06:17:02 INFO - PROCESS | 24023 | [#3] audio-fft Cycles:10 Average:90.70 Median:72.00 stddev:23.10 (32.1%) stddev-sans-first:23.60 06:17:02 INFO - PROCESS | 24023 | Values: 73.0 75.0 119.0 111.0 76.0 72.0 72.0 129.0 108.0 72.0 06:17:02 INFO - PROCESS | 24023 | 06:17:02 INFO - PROCESS | 24023 | [#4] audio-oscillator Cycles:10 Average:111.40 Median:93.00 stddev:29.45 (31.7%) stddev-sans-first:30.47 06:17:02 INFO - PROCESS | 24023 | Values: 93.0 93.0 160.0 93.0 93.0 95.0 157.0 93.0 93.0 144.0 06:17:02 INFO - PROCESS | 24023 | 06:17:02 INFO - PROCESS | 24023 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 06:17:02 INFO - PROCESS | 24023 | Values: 117.0 118.0 118.0 117.0 117.0 117.0 116.0 117.0 116.0 116.0 06:17:02 INFO - PROCESS | 24023 | 06:17:02 INFO - PROCESS | 24023 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 06:17:02 INFO - PROCESS | 24023 | Values: 146.0 146.0 146.0 145.0 145.0 145.0 145.0 145.0 147.0 147.0 06:17:02 INFO - PROCESS | 24023 | 06:17:02 INFO - PROCESS | 24023 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 06:17:02 INFO - PROCESS | 24023 | Values: 94.0 94.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 06:17:02 INFO - PROCESS | 24023 | 06:17:02 INFO - PROCESS | 24023 | [#8] json-parse-financial Cycles:10 Average:59.10 Median:58.50 stddev:4.33 (7.4%) stddev-sans-first:4.58 06:17:02 INFO - PROCESS | 24023 | Values: 58.0 59.0 58.0 58.0 59.0 57.0 59.0 71.0 56.0 56.0 06:17:02 INFO - PROCESS | 24023 | 06:17:02 INFO - PROCESS | 24023 | [#9] json-stringify-tinderbox Cycles:10 Average:61.40 Median:61.50 stddev:0.84 (1.4%) stddev-sans-first:0.73 06:17:02 INFO - PROCESS | 24023 | Values: 60.0 61.0 62.0 61.0 62.0 61.0 61.0 62.0 63.0 61.0 06:17:02 INFO - PROCESS | 24023 | 06:17:02 INFO - PROCESS | 24023 | [#10] stanford-crypto-aes Cycles:10 Average:76.80 Median:77.00 stddev:1.55 (2.0%) stddev-sans-first:1.62 06:17:02 INFO - PROCESS | 24023 | Values: 76.0 75.0 75.0 76.0 76.0 76.0 78.0 78.0 79.0 79.0 06:17:02 INFO - PROCESS | 24023 | 06:17:02 INFO - PROCESS | 24023 | [#11] stanford-crypto-ccm Cycles:10 Average:131.20 Median:129.00 stddev:12.31 (9.5%) stddev-sans-first:13.05 06:17:02 INFO - PROCESS | 24023 | Values: 130.0 126.0 137.0 126.0 131.0 122.0 124.0 124.0 164.0 128.0 06:17:02 INFO - PROCESS | 24023 | 06:17:02 INFO - PROCESS | 24023 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:200.10 Median:200.50 stddev:3.21 (1.6%) stddev-sans-first:3.32 06:17:02 INFO - PROCESS | 24023 | Values: 198.0 198.0 201.0 197.0 200.0 201.0 197.0 208.0 200.0 201.0 06:17:02 INFO - PROCESS | 24023 | 06:17:02 INFO - PROCESS | 24023 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:70.50 stddev:2.11 (3.0%) stddev-sans-first:1.67 06:17:02 INFO - PROCESS | 24023 | Values: 66.0 71.0 68.0 71.0 70.0 70.0 69.0 70.0 71.0 74.0 06:17:02 INFO - PROCESS | 24023 | -------- Summary: end -------- 06:17:02 INFO - PROCESS | 24023 | 06:17:03 INFO - TEST-INFO | 24023: exit 0 06:17:03 INFO - TEST-OK | kraken | took 61376ms 06:17:03 INFO - SUITE-END | took 1173s 06:17:03 INFO - Completed test suite (00:19:33) 06:17:03 INFO - javascript benchmark 06:17:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3098.9070327890163, 3120.2043478912874, 3150.9369812603736, 3176.4917613181897, 3201.2797120647856, 5149.330587023682, 5242.344706911636, 5260.447652996438, 5294.57643388529, 5327.334083239595, 5309.548688361494, 5314.256004159421, 5318.547923426504, 5407.270018547495, 5446.972765136179, 4798.040391921612, 4827.662063655545, 4904.06822703687, 4960.0, 4975.502449755032, 4904.877378065559, 4919.655624106314, 4939.58013568847, 4942.851714448572, 4972.328735620681, 4749.548792864673, 4757.762111894409, 4794.9520504794855, 4799.856004319876, 4802.303665968432, 4803.279508073817, 4806.375171227753, 4812.614990800727, 4826.493218212072, 4857.562819346241, 4679.321498382749, 4759.7620118994255, 4774.355462012619, 4778.474367819537, 4843.975780121112, 5133.974330128325, 5154.871128221825, 5155.072087024334, 5155.536001759822, 5220.895582088375, 5680.204771332017, 5681.7727290908315, 5707.058335374658, 5708.914366284509, 5710.486056254916, 5595.63628364155, 5609.4390560943575, 5652.378238393773, 5754.165645981351, 5756.7121643917635, 5254.369475662945, 5255.737213139404, 5273.0, 5277.788888444457, 5302.072137375943, 5752.913706294409, 5758.827235182951, 5759.280089988752, 5760.53915686744, 5781.53747700183, 5407.675539467566, 5504.779808807683, 5542.0855558832345, 5585.804496842591, 5607.299087614048, 5577.191307260425, 5589.636673616202, 5591.161325801162, 5592.636478628876, 5594.384617692051, 5571.052921003439, 5572.637778544382, 5574.331080270394, 5581.832545023656, 5583.379429602241, 5605.1031834907035, 5637.6617402955135, 5678.943210567924, 5715.114157305624, 5733.483986441241, 4305.354196870432, 4307.181635489247, 4309.116631090619, 4310.224159651293, 4344.674149438804, 3790.223004284115, 3845.9821981999407, 3851.306764782366, 3894.1627550076305, 3907.8046097695, 5383.703896285742, 5409.891802163935, 5410.702411367412, 5453.10023846061, 5459.590530710213, 5546.861328466821, 5578.497935185853, 5579.972100139474, 5581.665100094007, 5584.944150558524, 5277.9472205278225, 5294.0, 5307.920381194285, 5315.3621565412395, 5375.973120134374, 4859.052484765508, 4876.561109500162, 4878.487758785347, 4882.877928051827, 4923.113839508923, 5858.648481091148, 5892.204552385459, 5892.528597712173, 5897.911531327033, 5944.791932282349, 5598.188262701804, 5686.9715651421475, 5702.0, 5706.2011318414625, 5787.826365209051, 5875.177475153397, 5878.088896221093, 5878.353381127987, 5883.441073098049, 5884.911726324023, 5587.804426845041, 5596.38439771633, 5597.048501754793, 5598.468145526169, 5598.776048957996, 5598.440155984369, 5657.858553536194, 5685.573581981285, 5719.084946408721, 5720.542356611378, 5497.285352904097, 5497.890042199214, 5509.559235261089, 5512.090505066619, 5514.531264842373, 5441.591880608891, 5485.835424937259, 5498.5876059294915, 5499.560035197094, 5549.889002220014, 5413.269208656781, 5467.835964921059, 5497.5601951842955, 5526.50261476469, 5541.556675466034, 5519.475649813261, 5530.6128570999645, 5553.444655534414, 5554.805581804779, 5555.138953462219, 5432.402435731988, 5438.891222175614, 5439.673619582838, 5439.939211853809, 5445.618806683653], "value": 5219.04408721122, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.7301214453497, 645.956779800622, 647.9729628538765, 659.3472462262362, 668.0246839614163, 31793.0, 32400.67599324009, 32417.351652966925, 37005.25989480209, 37991.81004094983, 38629.03427414316, 39208.0, 39363.21273574527, 39423.0, 39509.20981580367, 8470.152984701526, 8737.0, 8748.431351962134, 8750.606222719993, 8753.299736021136, 8603.096674849145, 8737.082606326308, 8738.519381434018, 8743.256823170039, 8743.693970711027, 8729.738107856774, 8796.516191609491, 8801.0, 8806.471611703286, 8808.251298639623, 8678.913210867873, 8743.475391476532, 8747.16901894319, 8749.956250218707, 8753.562321883945, 8558.700445484377, 8641.265492433151, 8657.740267791976, 8672.60973256205, 8687.391882568223, 38901.0, 39303.606963930564, 39321.41017884734, 39344.80327598372, 39517.80241098805, 3724.4971928789537, 3745.606711295302, 3835.9041023974346, 3893.9415908761393, 4357.237483440385, 30065.849670751508, 30559.541606875915, 30582.0, 30615.234619134477, 31928.20179495508, 4176.60322269384, 4194.874153775391, 4228.133232687292, 4237.343211802176, 4295.978520107379, 191789.0, 191836.0, 191947.04026479917, 192104.0, 192408.0, 32042.83978580139, 55168.44831551633, 55822.441775582534, 55836.72081639566, 55930.720346398004, 33495.83252083724, 33508.49737253943, 33652.663473364955, 33674.663253367646, 33686.49470257948, 13354.265515396746, 13518.0, 13567.1859688419, 13615.455381784815, 13618.250996195105, 11166.050885674646, 11240.100791936626, 11308.434578271053, 11316.94341528287, 11322.37726925027, 8142.959285203655, 8217.301529369952, 8254.669813207525, 8274.462159959583, 8363.95818020906, 3223.3875563642832, 3247.074583743669, 3254.0, 3271.116798464401, 3303.752218583616, 1062.6068354708807, 1065.9200559958035, 1086.2287775679356, 1124.668222874254, 1194.743130226988, 30506.84746576253, 30749.38501229963, 31103.567393219182, 31270.84364578208, 31722.365552688818, 1101.9504122314354, 1113.3153110836777, 1114.7157474843864, 1128.1877048525048, 1209.5524655877382, 15759.821943124936, 16401.0, 16644.667106658042, 16650.75023874643, 16808.0, 368266.0, 369660.0, 369840.0, 371571.0, 373871.0, 53837.73081134569, 54221.72889135608, 54574.454255457735, 54594.18108728372, 54697.1795423069, 1366.863313668625, 1375.938082786277, 1382.0740104130257, 1384.3770303363526, 1405.7118290750373, 27593.58609620817, 29212.26969325784, 30113.247168820955, 30118.84940575283, 30129.0, 44916.326255105545, 44980.77509612562, 45342.0, 45379.54620453753, 45411.545884540734, 230626.0, 231557.0, 232612.0216393511, 232725.0, 232888.0, 23007.65488517707, 25560.488790224463, 25634.0, 25861.224163275132, 27348.0, 42974.355384668626, 43038.35442468303, 44161.77919110384, 44492.33261501145, 44643.776781115885, 37217.241998922225, 37814.24371512499, 37897.81051094727, 38499.0, 38531.2293754129, 36752.61761206051, 37374.0, 37726.0, 37860.81069594635, 38375.23249534938, 38028.42957355586, 38335.80832095822, 38781.224375512895, 38801.805990969864, 39269.0, 32720.0, 33449.83275083609, 34126.31747365089, 34272.82863585666, 34355.484667729506, 25906.611400828624, 26130.86934565391, 26797.464050719267, 26940.32649183786, 27133.72866271312], "value": 17286.355154494697, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.14127224838376, 378.19255888677674, 382.1630628922661, 389.09147141424774, 391.6670829794677, 16996.660066798657, 17299.39452119176, 18334.174962126704, 18449.354272600463, 18462.630747385043, 16103.758443623326, 16419.17904104796, 16661.91669041656, 16705.415310464137, 17462.563435914108, 5377.435369286218, 5628.212050312939, 5635.380108188096, 5662.716864156796, 5672.0, 4167.499900012002, 5161.225816127592, 6161.199044124258, 6211.0, 6216.0, 5931.495822855062, 6044.365341639131, 6080.756769729228, 6087.178230938811, 6114.81655550332, 5865.237519122529, 5957.046872500379, 5958.791442299499, 5961.493273071773, 5962.224910761595, 5067.569256613192, 5305.0450918834595, 5379.623426360156, 5386.973065134688, 5389.78440862365, 11494.195406321562, 11603.303801771921, 11667.88332116685, 11689.298642081418, 11705.941470292593, 2183.5960347335795, 2223.1774243529835, 2301.9884900575557, 2310.1567927706433, 2315.0855412112123, 9092.454282771945, 9224.953875230582, 9242.260619150451, 10925.726856828564, 12632.157764503005, 1888.9149988250424, 1976.9209231630718, 1993.5016245938516, 1994.38174166009, 2053.1787285085934, 63592.68203658952, 64831.67584162096, 66013.0, 66079.0, 67226.0, 10224.233182511342, 10264.589416423409, 10349.741256468498, 10571.735706607242, 10869.67390978272, 14332.57002289933, 14368.784468232985, 14389.712205755826, 14425.639359015899, 14428.278586070865, 7377.741779037815, 7645.120811106683, 7702.691892324357, 7792.922070779333, 7796.883046754303, 7301.780946571611, 7365.337119659149, 7414.110306763115, 7434.25657434263, 7493.775186744407, 4234.576542345741, 4268.914621707549, 4331.5451877552405, 4502.909941801146, 4686.27362758773, 1829.9203469952793, 1850.7871594766775, 1873.6627407066858, 1877.4555378940227, 1881.1628825172668, 1019.7097596540082, 1032.7831155457288, 1087.49975011494, 1113.9610113645983, 1122.5509796081633, 10278.17774578032, 10332.431716255678, 17080.316787328367, 17465.38871139504, 17940.102994850204, 425.4936625415807, 427.04342273307566, 429.5661382004198, 434.2400798602446, 435.8779541728321, 5437.809676661377, 5555.166724991283, 5605.131204663202, 5714.942850571524, 5751.1085781703905, 501279.0, 510817.0, 511034.0, 523111.0, 524228.0, 59615.40384596185, 70430.2956970434, 71025.28974710187, 75742.31932604966, 80587.0, 419.7733224059035, 424.581786939864, 425.5659227587905, 426.3242760225016, 427.9358096285582, 9866.125436167105, 9880.950595246977, 9930.0, 10118.342307749972, 10175.0, 34725.0, 34830.47754283637, 35949.28101438009, 36262.63737362593, 37118.25763484661, 49165.0, 49337.75331123465, 49772.25341619806, 50735.2389714162, 50774.23838642497, 7705.653245603849, 7927.365810735012, 7948.8807667883875, 8016.438849280495, 8115.0, 10406.947965260428, 12415.751684966432, 12470.68823279389, 12475.376231188586, 12726.68183295425, 11016.889831101907, 11101.668649583355, 11195.776084478102, 11346.319220846775, 11348.0, 11090.279131856403, 11442.199046066695, 11538.0, 11640.417979101181, 11648.592299269485, 11658.125640576822, 11753.529858805552, 11789.528418863149, 11799.705007374541, 11881.0, 7832.177621349676, 7878.133405325524, 7956.323712484504, 8064.919350806652, 8420.536870472182, 8212.096669366485, 10683.25217234786, 11447.771044578894, 11584.594539191088, 11705.030050624637], "value": 7917.038301231741, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1364.8225730655013, 1475.8081449411573, 1501.8122734658168, 1657.5110342448977, 1804.1249993753027, 7168.0, 7748.651310691018, 7917.960410197956, 7963.681452741891, 7970.880436793438, 7735.342495887856, 7882.60586970652, 7883.132855385903, 7884.172161923001, 7891.881621775678, 2165.079841067544, 2197.1870407949, 2198.912043518257, 2200.515886504966, 2202.6695995600708, 2140.9785902140934, 2151.7310336207975, 2177.16179270981, 2180.0, 2192.0793266827973, 2104.9789502105014, 2128.1168315149193, 2128.2338358191037, 2128.8616239944354, 2184.650455927052, 2164.3290579920276, 2178.934631961036, 2183.683365911934, 2183.8034576888076, 2184.1154332495366, 2077.5637116205617, 2118.7033815265877, 2128.7658357580654, 2133.1680644548637, 2133.6266153423244, 7763.767086987399, 7973.32226760726, 8007.519548827089, 8013.679452821939, 8030.036395632503, 4549.31760235964, 4672.345871577982, 4672.906541869178, 4679.60223381013, 4680.719156850566, 2981.4484320400798, 2990.2673844908136, 3030.863611137504, 3041.832699201543, 3058.5565093061605, 1058.6506452870535, 2005.418428655688, 2063.8658487198286, 2067.1627990663806, 2112.714783504223, 10639.627613033506, 10776.19178561611, 10780.784384312348, 10795.352278863214, 10803.5678572857, 3931.1744533647684, 4034.8789536313957, 4046.5346485154582, 4189.0, 4328.761918094535, 8663.35024873137, 8677.783055423539, 8749.256313213447, 8751.212390884724, 8757.2994160467, 4738.976305118453, 4748.6438517111355, 4755.83354582588, 4766.118268120339, 4766.165920963817, 3982.4623675803973, 4065.308897487434, 4131.648809851196, 4479.014616784302, 4490.550944905549, 3465.220325426759, 3475.548178736748, 3525.8413371398346, 3553.5558055243096, 3554.7689400188906, 1051.8737751469719, 1055.3984228989557, 1057.8783439904355, 1058.0424715632364, 1063.2610335816687, 837.2172019161981, 902.6840605788053, 979.480875136179, 981.6907674082642, 986.1322036607739, 5721.742521586539, 5795.9420405796245, 5824.0, 5914.970425147847, 6028.517718582503, 400.95389030261896, 402.90531725044593, 402.9858954936563, 407.09827731574705, 412.15096900385305, 3924.1955399143108, 4015.297322968469, 4070.8575199867864, 4123.60825721556, 4325.416068830667, 9288.7677808054, 9815.656452024288, 9869.901300986898, 9880.505974701236, 9906.10845023937, 9604.08761167688, 9758.46328451942, 9760.170385517169, 9761.023897610183, 9770.120689138012, 7249.8550028999125, 7265.4187664986675, 7394.55632662042, 7424.257574242424, 7513.2111128330735, 5764.0, 5776.566757493289, 5863.208466857091, 5983.401659834156, 5985.25184351956, 8963.148500892405, 9139.862902056342, 9341.626334946526, 9353.859692104488, 9425.717228483156, 9414.57634406467, 9414.811703766023, 9548.236141108833, 9553.426794392359, 9563.808723825345, 6588.670566471561, 7005.614691192033, 7188.101487314086, 7242.818929526593, 7256.492045556972, 7839.451238413257, 7871.606419678878, 7929.286364227247, 7936.404769642415, 7965.8406831864195, 7185.676644550903, 7211.206767255702, 7346.0, 7435.8141046474275, 7457.0, 7148.356647901714, 7176.641167941686, 7178.5692858428665, 7301.233370496234, 7318.524295920748, 6737.0, 6817.761378351734, 6819.420349270367, 6824.761133360308, 6828.897566536605, 4776.641751868554, 4853.927191092066, 4917.336159618406, 5075.238714192753, 5122.897542049063, 5188.143956247177, 5191.506806853343, 5258.579313654975, 5272.0, 5304.7347632618985], "value": 4260.883468574521, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.8880081168749, 304.88414402527036, 307.81992534367384, 308.8332300557699, 310.37769272608415, 5200.141976573861, 5276.8153114641, 5278.445763194862, 5278.996990571789, 5304.522592966632, 4981.427135879375, 5073.264376665391, 5179.792808287673, 5220.243064755608, 5243.10867152584, 4074.0, 4100.446439730643, 4134.64855487284, 4136.462259906208, 4137.85517506888, 4101.912993056842, 4109.979450102745, 4125.0, 4132.5454200037975, 4134.400511925769, 3886.8039557649836, 4012.1373904610505, 4085.508789291902, 4102.743491079909, 4109.0, 4040.717149799515, 4046.898827529306, 4061.939070913939, 4088.2641124597562, 4100.548939616655, 3622.2031153146268, 3622.836972336225, 3634.6547078027547, 3636.472711456824, 3642.8724994625327, 4817.590504807095, 5021.799128034874, 5079.619028572872, 5088.363954505687, 5105.591552675777, 4552.795124219418, 4563.292689633112, 4580.427446569179, 4590.173768721629, 4621.676482646216, 5480.890382192374, 5484.61607687462, 5485.424030476823, 5490.313710786152, 5491.862703432406, 3651.3062518121737, 3782.451544526028, 3830.7126965477423, 3868.3423817951016, 3889.9222015559812, 5653.293338332708, 5654.434556544354, 5668.489835914746, 5705.942940570582, 5714.885702285931, 3916.4712763777097, 3959.5644479107277, 3972.0, 3972.371327755606, 3981.223661386002, 3924.175923056133, 3998.8600398985895, 4018.176273863851, 4027.2952233359047, 4035.5762644922447, 4595.540445955377, 4600.585947264763, 4606.631469482433, 4611.1930412177735, 4612.884677883079, 5529.640573362719, 5557.943990641846, 5558.360788509373, 5562.360328562268, 5568.860778480489, 1337.7592033434075, 1354.0995238166706, 1446.088963952724, 1460.5837336359086, 1462.8317743459424, 952.1097773581723, 961.6153538584482, 963.4989805301204, 966.8114717629994, 973.634886917406, 5601.747921343549, 5605.439456054362, 5625.971870140705, 5646.887062258732, 5739.971300143473, 5908.911366329508, 6033.3061697905305, 6036.426539478743, 6073.301570319381, 6104.511639068864, 5560.944390556043, 5605.5795815313195, 5676.233708449389, 5724.914126288109, 5726.255586773693, 3134.3104517006223, 3214.2928555717704, 3230.3700778347998, 3231.88688395905, 3232.9838350808095, 6052.909206361908, 6146.385361463817, 6159.4456498915315, 6178.938210617926, 6251.718672659741, 6067.635941843503, 6072.969635151796, 6082.361352058058, 6093.573449858556, 6101.298350689639, 6031.366706495754, 6174.413430724074, 6178.69106544671, 6179.640479094592, 6190.41191086846, 5908.852278693067, 5961.165436838759, 5980.910286345796, 5989.251343582052, 5997.310309314485, 5873.9720548902915, 5907.202527658883, 5908.3500814911185, 5914.260717410324, 5921.940780592139, 5930.911036334544, 6154.938450615616, 6174.567780255339, 6181.938180618136, 6204.720787564661, 4099.1596722672375, 4101.097758493127, 4105.58944105587, 4106.404571337199, 4137.544870064351, 5466.945330546644, 5492.780288788404, 5672.9221447924765, 6007.579469437097, 6015.1278064681255, 5546.278983732089, 5553.916986187654, 5582.469665381782, 5601.719914004202, 5639.971800140973, 5520.641158324696, 5536.806211782568, 5556.944180605672, 5570.0, 5591.692456914909, 5225.790968361375, 5409.727914276093, 5432.728363581726, 5504.91742623869, 5578.86052848682, 5540.556755459635, 5564.332280126248, 5660.603757736919, 5665.376808550974, 5666.121751128581, 5252.264682944315, 5481.753321100639, 5519.530839878495, 5536.889262214814, 5564.860878478071], "value": 4264.397675426413, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [795.3517882925416, 804.4208170117515, 833.5082301442147, 842.2209456252964, 842.9578521073945, 14611.853881461195, 14676.706465870677, 14761.261936903138, 14809.3335799889, 14813.851861481382, 12034.33811140387, 12892.226466412021, 12986.93506532466, 13019.73960520789, 13027.60917172484, 790.4664351562686, 824.3775949158407, 827.0323721246126, 828.1470085811594, 828.1635548096406, 823.7899335669426, 827.611022819277, 830.7134038756619, 830.8296799156159, 831.1605278668528, 717.8420747435556, 837.1712005114953, 864.6584599083359, 864.7924498120437, 866.7139843851514, 854.1714536899229, 854.5641722721394, 855.0167307596283, 855.6192494340021, 857.5283594023293, 633.1357696743958, 633.4267487923437, 633.7971849008319, 633.8922383194868, 633.9936600634027, 13045.86954130456, 13091.214527128403, 13124.868751312555, 13135.34323283832, 13144.605661830064, 13698.109622874581, 14558.636034099127, 14614.34235459407, 14655.780163297559, 14693.118412895261, 11837.585684501088, 11855.288682679067, 11868.169228154033, 12076.637700868989, 12229.510819567207, 3895.668868146211, 3920.4511368408444, 3927.8036098194975, 4008.098177909976, 4020.336644453662, 54469.455305446834, 54780.0, 55570.0, 56009.71995140039, 56259.43740562542, 11020.614278500214, 11432.428378581038, 11525.654230373102, 11555.133364997491, 11791.233569817934, 20674.276400326216, 20694.896525517277, 20708.0, 20722.792772072087, 20744.688829667568, 8243.752687419386, 8550.786230344167, 8762.386632935633, 8844.911550884537, 8879.733607991771, 4813.374261346003, 4884.3161957326, 4924.285978533093, 4976.5023497649945, 5085.618578606619, 3185.1877771168206, 3266.771326007204, 3270.0680306113118, 3271.6401195868434, 3271.672832716757, 509.76550786638563, 621.0342916764384, 629.9275583307887, 632.6615260835431, 635.0, 746.171749358212, 785.9449838511364, 787.8542469643135, 803.1647087029424, 810.5136917849243, 8762.342824288204, 8854.822903542023, 8875.0, 8956.462612243286, 9054.139856713602, 738.8928605352194, 767.9923200768033, 770.2259229474342, 777.6345117794627, 780.6877249100291, 4341.630961368256, 4490.663200259994, 4491.281394976853, 4499.55004499554, 4562.110388474282, 56918.43081569214, 57625.0, 57711.0, 60216.0, 68276.6586167066, 53519.464805352225, 56362.71818640963, 56397.15404268939, 57176.71411642998, 57949.420505794405, 51967.480325196266, 52011.219831702554, 52305.21542176794, 52883.20675189798, 53577.732111339974, 9058.90941090607, 9215.631374745204, 9375.203107735646, 9397.342186046912, 9428.811423771349, 32210.83894580512, 33252.0, 33571.664283356855, 34009.31981360408, 34447.0, 45297.54702452933, 46537.301940471596, 46978.06043879172, 47258.29112563246, 47443.28835067546, 11570.537178512765, 11777.646670599896, 12178.756424871275, 12281.447334869774, 12309.630711078682, 13233.07368484197, 13306.55234783276, 13484.393202305724, 13771.655708607364, 13836.515721949683, 12317.199382040497, 12515.812262815884, 12652.0, 12669.8099528509, 12749.745005099661, 12453.315067671365, 12646.936765316115, 12891.548795792101, 13030.218186908816, 13298.933505332412, 12225.083118766306, 12268.877311226774, 12435.129540932048, 12629.684257893627, 12860.614181574567, 10590.8940910593, 10757.408342540923, 10760.461976900968, 10830.458477075957, 11213.66359009231, 10504.159667226451, 10740.946295268473, 10830.133589312994, 10848.643919510061, 10874.456277186267], "value": 6836.621052181561, "unit": "score"}], "name": "dromaeo_css", "value": 6678.558252760333, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 111.0, 107.0, 111.0, 111.0, 112.0, 101.0, 109.0, 110.0, 110.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 129.0, 157.0, 191.0, 130.0, 155.0, 159.0, 135.0, 191.0, 133.0], "value": 154.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 161.0, 160.0, 160.0, 160.0, 160.0, 160.0, 162.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 119.0, 111.0, 76.0, 72.0, 72.0, 129.0, 108.0, 72.0], "value": 90.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 160.0, 93.0, 93.0, 95.0, 157.0, 93.0, 93.0, 144.0], "value": 111.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 147.0, 147.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 58.0, 58.0, 59.0, 57.0, 59.0, 71.0, 56.0, 56.0], "value": 59.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 62.0, 61.0, 62.0, 61.0, 61.0, 62.0, 63.0, 61.0], "value": 61.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 76.0, 76.0, 76.0, 78.0, 78.0, 79.0, 79.0], "value": 76.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 126.0, 137.0, 126.0, 131.0, 122.0, 124.0, 124.0, 164.0, 128.0], "value": 131.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 198.0, 201.0, 197.0, 200.0, 201.0, 197.0, 208.0, 200.0, 201.0], "value": 200.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 71.0, 68.0, 71.0, 70.0, 70.0, 69.0, 70.0, 71.0, 74.0], "value": 70.0, "unit": "score"}], "name": "kraken", "value": 1582.1999999999998, "alertThreshold": 2.0}]} 06:17:03 INFO - Return code: 0 06:17:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:17:03 ERROR - # TBPL SUCCESS # 06:17:03 INFO - Running post-action listener: _resource_record_post_action 06:17:03 INFO - Running post-run listener: _resource_record_post_run 06:17:04 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 543027200; Read time: 8; Write time: 661704 06:17:04 INFO - install - Wall time: 17s; CPU: 16.0%; Read bytes: 0; Write bytes: 240857088; Read time: 0; Write time: 469312 06:17:04 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 287711232; Read time: 8; Write time: 190168 06:17:04 INFO - Running post-run listener: _upload_blobber_files 06:17:04 INFO - Blob upload gear active. 06:17:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:17:04 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 06:17:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:17:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:17:05 INFO - (blobuploader) - INFO - Open directory for files ... 06:17:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:17:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:17:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:17:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:17:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:17:06 INFO - (blobuploader) - INFO - Done attempting. 06:17:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:17:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:17:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:17:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:17:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:17:07 INFO - (blobuploader) - INFO - Done attempting. 06:17:07 INFO - (blobuploader) - INFO - Iteration through files over. 06:17:07 INFO - Return code: 0 06:17:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:17:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:17:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/080b99f12fd403db00a7a67584d89a408aa3f060e6182b468393faee4747d662dfc022901c23d5d1366cb5e0fb2cba3223f6e273a8b10a187b44e6d7471aee82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/896b544cfdfa9794ddbd00ec398e010c8db87aa495f49fa56a2dc0ea45261012a77d321eeeee28eb1492ef21a0cfc4970db86ea236fc6f4273c87d4b62605373"} 06:17:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:17:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:17:07 INFO - Contents: 06:17:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/080b99f12fd403db00a7a67584d89a408aa3f060e6182b468393faee4747d662dfc022901c23d5d1366cb5e0fb2cba3223f6e273a8b10a187b44e6d7471aee82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/896b544cfdfa9794ddbd00ec398e010c8db87aa495f49fa56a2dc0ea45261012a77d321eeeee28eb1492ef21a0cfc4970db86ea236fc6f4273c87d4b62605373"} 06:17:07 INFO - Running post-run listener: copy_logs_to_upload_dir 06:17:07 INFO - Copying logs to upload dir... 06:17:07 INFO - mkdir: /builds/slave/test/build/upload/logs 06:17:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.368029 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-04-27 06:17:06.969516) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-27 06:17:06.973356) ========= 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=00204705a9daa57ed339a427000001b9-1461760749.345133-521570645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/080b99f12fd403db00a7a67584d89a408aa3f060e6182b468393faee4747d662dfc022901c23d5d1366cb5e0fb2cba3223f6e273a8b10a187b44e6d7471aee82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/896b544cfdfa9794ddbd00ec398e010c8db87aa495f49fa56a2dc0ea45261012a77d321eeeee28eb1492ef21a0cfc4970db86ea236fc6f4273c87d4b62605373"} build_url:https://queue.taskcluster.net/v1/task/TKZdTZZrQOeT4I2Ou6DOcQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011307 build_url: 'https://queue.taskcluster.net/v1/task/TKZdTZZrQOeT4I2Ou6DOcQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/080b99f12fd403db00a7a67584d89a408aa3f060e6182b468393faee4747d662dfc022901c23d5d1366cb5e0fb2cba3223f6e273a8b10a187b44e6d7471aee82", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/896b544cfdfa9794ddbd00ec398e010c8db87aa495f49fa56a2dc0ea45261012a77d321eeeee28eb1492ef21a0cfc4970db86ea236fc6f4273c87d4b62605373"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-27 06:17:07.003616) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 06:17:07.004367) ========= 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=00204705a9daa57ed339a427000001b9-1461760749.345133-521570645 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004467 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 06:17:07.085776) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-27 06:17:07.086165) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-27 06:17:07.086912) ========= ========= Total master_lag: 0.18 =========