builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-033 starttime: 1462884242.85 results: success (0) buildid: 20160510030240 builduid: 66b5fe52ad514bcb96b5aeff48bc1ebc revision: 043082cb7bd8490c60815f67fbd1f33323ad7663 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 05:44:02.846248) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 05:44:02.846652) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-10 05:44:02.846923) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-10 05:44:02.864448) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 05:44:02.865004) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1462884241.694061-1217471790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-10 05:44:03-- 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% 69.4M=0s 2016-05-10 05:44:03 (69.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.129225 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 05:44:03.008710) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 05:44:03.009030) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1462884241.694061-1217471790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015533 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 05:44:03.057796) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 05:44:03.058097) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 043082cb7bd8490c60815f67fbd1f33323ad7663 --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 043082cb7bd8490c60815f67fbd1f33323ad7663 --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=edae0fb5fee9fb758e8af6d3000002a4-1462884241.694061-1217471790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-10 05:44:03,266 truncating revision to first 12 chars 2016-05-10 05:44:03,266 Setting DEBUG logging. 2016-05-10 05:44:03,266 attempt 1/10 2016-05-10 05:44:03,266 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/043082cb7bd8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-10 05:44:03,533 unpacking tar archive at: mozilla-central-043082cb7bd8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.559530 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 05:44:03.630578) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 05:44:03.630926) ========= script_repo_revision: 043082cb7bd8490c60815f67fbd1f33323ad7663 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 05:44:03.631393) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-10 05:44:03.631714) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-10 05:44:03.642159) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-05-10 05:44:03.642481) ========= /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=edae0fb5fee9fb758e8af6d3000002a4-1462884241.694061-1217471790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:44:03 INFO - MultiFileLogger online at 20160510 05:44:03 in /builds/slave/test 05:44:03 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:44:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:44:03 INFO - {'append_to_log': False, 05:44:03 INFO - 'base_work_dir': '/builds/slave/test', 05:44:03 INFO - 'blob_upload_branch': 'Firefox', 05:44:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:44:03 INFO - 'branch': 'Firefox', 05:44:03 INFO - 'buildbot_json_path': 'buildprops.json', 05:44:03 INFO - 'config_files': ('talos/linux_config.py',), 05:44:03 INFO - 'default_actions': ('clobber', 05:44:03 INFO - 'read-buildbot-config', 05:44:03 INFO - 'download-and-extract', 05:44:03 INFO - 'populate-webroot', 05:44:03 INFO - 'create-virtualenv', 05:44:03 INFO - 'install', 05:44:03 INFO - 'run-tests'), 05:44:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:44:03 INFO - 'download_minidump_stackwalk': True, 05:44:03 INFO - 'download_symbols': 'ondemand', 05:44:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:44:03 INFO - 'tooltool.py': '/tools/tooltool.py', 05:44:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:44:03 INFO - '/tools/misc-python/virtualenv.py')}, 05:44:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:44:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:44:03 INFO - 'installer_path': 'installer.exe', 05:44:03 INFO - 'log_level': 'info', 05:44:03 INFO - 'log_name': 'talos', 05:44:03 INFO - 'log_to_console': True, 05:44:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:44:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:44:03 INFO - 'opt_config_files': (), 05:44:03 INFO - 'pip_index': False, 05:44:03 INFO - 'sps_profile': False, 05:44:03 INFO - 'sps_profile_interval': 0, 05:44:03 INFO - 'suite': 'dromaeojs', 05:44:03 INFO - 'system_bits': '32', 05:44:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:44:03 INFO - 'title': 'talos-linux64-ix-033', 05:44:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:44:03 INFO - 'use_talos_json': True, 05:44:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:44:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:44:03 INFO - 'work_dir': 'build'} 05:44:03 INFO - ##### 05:44:03 INFO - ##### Running clobber step. 05:44:03 INFO - ##### 05:44:03 INFO - Running pre-action listener: _resource_record_pre_action 05:44:03 INFO - Running main action method: clobber 05:44:03 INFO - rmtree: /builds/slave/test/build 05:44:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:44:04 INFO - Running post-action listener: _resource_record_post_action 05:44:04 INFO - ##### 05:44:04 INFO - ##### Finished clobber step (success) 05:44:04 INFO - ##### 05:44:04 INFO - ##### 05:44:04 INFO - ##### Running read-buildbot-config step. 05:44:04 INFO - ##### 05:44:04 INFO - Running pre-action listener: _resource_record_pre_action 05:44:04 INFO - Running main action method: read_buildbot_config 05:44:04 INFO - Using buildbot properties: 05:44:04 INFO - { 05:44:04 INFO - "project": "", 05:44:04 INFO - "product": "firefox", 05:44:04 INFO - "script_repo_revision": "production", 05:44:04 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:44:04 INFO - "repository": "", 05:44:04 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:44:04 INFO - "buildid": "20160510030240", 05:44:04 INFO - "stage_platform": "linux64-pgo", 05:44:04 INFO - "basedir": "/builds/slave/test", 05:44:04 INFO - "nightly_build": "True", 05:44:04 INFO - "buildnumber": 437, 05:44:04 INFO - "slavename": "talos-linux64-ix-033", 05:44:04 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:44:04 INFO - "platform": "ubuntu64_hw", 05:44:04 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:44:04 INFO - "branch": "mozilla-central", 05:44:04 INFO - "repo_path": "mozilla-central", 05:44:04 INFO - "revision": "043082cb7bd8490c60815f67fbd1f33323ad7663", 05:44:04 INFO - "pgo_build": "True", 05:44:04 INFO - "builduid": "66b5fe52ad514bcb96b5aeff48bc1ebc", 05:44:04 INFO - "slavebuilddir": "test" 05:44:04 INFO - } 05:44:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/IaJYfo7WRPOaXE0JMlX2Eg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 05:44:04 INFO - Running post-action listener: _resource_record_post_action 05:44:04 INFO - ##### 05:44:04 INFO - ##### Finished read-buildbot-config step (success) 05:44:04 INFO - ##### 05:44:04 INFO - ##### 05:44:04 INFO - ##### Running download-and-extract step. 05:44:04 INFO - ##### 05:44:04 INFO - Running pre-action listener: _resource_record_pre_action 05:44:04 INFO - Running main action method: download_and_extract 05:44:04 INFO - mkdir: /builds/slave/test/build/tests 05:44:04 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:44:04 INFO - https://queue.taskcluster.net/v1/task/IaJYfo7WRPOaXE0JMlX2Eg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:44:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IaJYfo7WRPOaXE0JMlX2Eg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:44:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IaJYfo7WRPOaXE0JMlX2Eg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:44:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IaJYfo7WRPOaXE0JMlX2Eg/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:44:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IaJYfo7WRPOaXE0JMlX2Eg/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:44:05 INFO - Downloaded 1361 bytes. 05:44:05 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:44:05 INFO - Using the following test package requirements: 05:44:05 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:44:05 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:44:05 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:44:05 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:44:05 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:44:05 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:44:05 INFO - u'jsshell-linux-x86_64.zip'], 05:44:05 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:44:05 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:44:05 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:44:05 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:44:05 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:44:05 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:44:05 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:44:05 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:44:05 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:44:05 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:44:05 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:44:05 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:44:05 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:44:05 INFO - https://queue.taskcluster.net/v1/task/IaJYfo7WRPOaXE0JMlX2Eg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:44:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IaJYfo7WRPOaXE0JMlX2Eg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:44:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IaJYfo7WRPOaXE0JMlX2Eg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:44:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IaJYfo7WRPOaXE0JMlX2Eg/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:44:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IaJYfo7WRPOaXE0JMlX2Eg/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:44:06 INFO - Downloaded 23895331 bytes. 05:44:06 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:44:06 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:44:07 INFO - Return code: 0 05:44:07 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:44:07 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:44:07 INFO - https://queue.taskcluster.net/v1/task/IaJYfo7WRPOaXE0JMlX2Eg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:44:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IaJYfo7WRPOaXE0JMlX2Eg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:44:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IaJYfo7WRPOaXE0JMlX2Eg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:44:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IaJYfo7WRPOaXE0JMlX2Eg/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:44:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IaJYfo7WRPOaXE0JMlX2Eg/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:44:08 INFO - Downloaded 23895331 bytes. 05:44:08 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:44:08 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:44:10 INFO - Return code: 0 05:44:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:10 INFO - https://queue.taskcluster.net/v1/task/IaJYfo7WRPOaXE0JMlX2Eg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:44:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IaJYfo7WRPOaXE0JMlX2Eg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:44:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IaJYfo7WRPOaXE0JMlX2Eg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:44:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IaJYfo7WRPOaXE0JMlX2Eg/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:44:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IaJYfo7WRPOaXE0JMlX2Eg/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:44:11 INFO - Downloaded 10840152 bytes. 05:44:11 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:44:11 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:44:11 INFO - Return code: 0 05:44:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:11 INFO - https://queue.taskcluster.net/v1/task/IaJYfo7WRPOaXE0JMlX2Eg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:44:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IaJYfo7WRPOaXE0JMlX2Eg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:44:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IaJYfo7WRPOaXE0JMlX2Eg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:44:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IaJYfo7WRPOaXE0JMlX2Eg/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:44:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IaJYfo7WRPOaXE0JMlX2Eg/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:44:12 INFO - Downloaded 58430200 bytes. 05:44:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IaJYfo7WRPOaXE0JMlX2Eg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:44:12 INFO - mkdir: /builds/slave/test/properties 05:44:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:44:12 INFO - Writing to file /builds/slave/test/properties/build_url 05:44:12 INFO - Contents: 05:44:12 INFO - build_url:https://queue.taskcluster.net/v1/task/IaJYfo7WRPOaXE0JMlX2Eg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:44:13 INFO - Running post-action listener: _resource_record_post_action 05:44:13 INFO - Running post-action listener: set_extra_try_arguments 05:44:13 INFO - ##### 05:44:13 INFO - ##### Finished download-and-extract step (success) 05:44:13 INFO - ##### 05:44:13 INFO - ##### 05:44:13 INFO - ##### Running populate-webroot step. 05:44:13 INFO - ##### 05:44:13 INFO - Running pre-action listener: _resource_record_pre_action 05:44:13 INFO - Running main action method: populate_webroot 05:44:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:44:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:44:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:44:13 INFO - '--tppagecycles', 05:44:13 INFO - '7'], 05:44:13 INFO - 'tests': ['tsvgm']}}, 05:44:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:44:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:44:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:44:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:44:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:44:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:44:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:13 INFO - 'talos_options': ['--disable-e10s'], 05:44:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:44:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:44:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:13 INFO - 'talos_options': ['--disable-e10s'], 05:44:13 INFO - 'tests': ['damp', 'tps']}, 05:44:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:13 INFO - 'tests': ['damp', 'tps']}, 05:44:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:44:13 INFO - 'tests': ['dromaeo_dom']}, 05:44:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:44:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:44:13 INFO - 'tests': ['a11yr', 05:44:13 INFO - 'ts_paint', 05:44:13 INFO - 'tpaint', 05:44:13 INFO - 'sessionrestore', 05:44:13 INFO - 'sessionrestore_no_auto_restore', 05:44:13 INFO - 'tabpaint']}, 05:44:13 INFO - 'other-e10s': {'tests': ['a11yr', 05:44:13 INFO - 'ts_paint', 05:44:13 INFO - 'tpaint', 05:44:13 INFO - 'sessionrestore', 05:44:13 INFO - 'sessionrestore_no_auto_restore', 05:44:13 INFO - 'tabpaint']}, 05:44:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:44:13 INFO - 'ts_paint', 05:44:13 INFO - 'tpaint', 05:44:13 INFO - 'sessionrestore', 05:44:13 INFO - 'sessionrestore_no_auto_restore', 05:44:13 INFO - 'tabpaint']}, 05:44:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:44:13 INFO - 'ts_paint', 05:44:13 INFO - 'tpaint', 05:44:13 INFO - 'sessionrestore', 05:44:13 INFO - 'sessionrestore_no_auto_restore', 05:44:13 INFO - 'tabpaint']}, 05:44:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:44:13 INFO - 'tests': ['a11yr', 05:44:13 INFO - 'ts_paint', 05:44:13 INFO - 'tpaint', 05:44:13 INFO - 'sessionrestore', 05:44:13 INFO - 'sessionrestore_no_auto_restore', 05:44:13 INFO - 'tabpaint']}, 05:44:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:44:13 INFO - 'tests': ['a11yr', 05:44:13 INFO - 'ts_paint', 05:44:13 INFO - 'tpaint', 05:44:13 INFO - 'sessionrestore', 05:44:13 INFO - 'sessionrestore_no_auto_restore', 05:44:13 INFO - 'tabpaint']}, 05:44:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:44:13 INFO - 'tests': ['tsvgx', 05:44:13 INFO - 'tsvgr_opacity', 05:44:13 INFO - 'tart', 05:44:13 INFO - 'tscrollx', 05:44:13 INFO - 'cart']}, 05:44:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:44:13 INFO - 'tsvgr_opacity', 05:44:13 INFO - 'tart', 05:44:13 INFO - 'tscrollx', 05:44:13 INFO - 'cart']}, 05:44:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:13 INFO - 'talos_options': ['--disable-e10s'], 05:44:13 INFO - 'tests': ['tp5o']}, 05:44:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:13 INFO - 'tests': ['tp5o']}, 05:44:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:13 INFO - 'talos_options': ['--disable-e10s', 05:44:13 INFO - '--xperf_path', 05:44:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:44:13 INFO - 'tests': ['tp5n']}, 05:44:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:44:13 INFO - 'talos_options': ['--xperf_path', 05:44:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:44:13 INFO - 'tests': ['tp5n']}}, 05:44:13 INFO - 'talos.zip': {'path': '', 05:44:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:44:13 INFO - Running post-action listener: _resource_record_post_action 05:44:13 INFO - ##### 05:44:13 INFO - ##### Finished populate-webroot step (success) 05:44:13 INFO - ##### 05:44:13 INFO - ##### 05:44:13 INFO - ##### Running create-virtualenv step. 05:44:13 INFO - ##### 05:44:13 INFO - Running pre-action listener: _resource_record_pre_action 05:44:13 INFO - Running main action method: create_virtualenv 05:44:13 INFO - Creating virtualenv /builds/slave/test/build/venv 05:44:13 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:44:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:44:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:44:13 INFO - Using real prefix '/usr' 05:44:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:44:14 INFO - Installing distribute.............................................................................................................................................................................................done. 05:44:15 INFO - Installing pip.................done. 05:44:15 INFO - Return code: 0 05:44:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:44:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:15 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 0x7f622143df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2010770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209f9c0>, '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 0x20a08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a0d50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1462884241.694061-1217471790', '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:44:15 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:44:15 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:44:15 INFO - Using env: {'DISPLAY': ':0', 05:44:15 INFO - 'HOME': '/home/cltbld', 05:44:15 INFO - 'LANG': 'en_US.UTF-8', 05:44:15 INFO - 'LANGUAGE': 'en_US:en', 05:44:15 INFO - 'LOGNAME': 'cltbld', 05:44:15 INFO - 'MAIL': '/var/mail/cltbld', 05:44:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:15 INFO - 'MOZ_NO_REMOTE': '1', 05:44:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:15 INFO - 'NO_EM_RESTART': '1', 05:44:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:44:15 INFO - 'PWD': '/builds/slave/test', 05:44:15 INFO - 'SHELL': '/bin/bash', 05:44:15 INFO - 'SHLVL': '1', 05:44:15 INFO - 'TERM': 'linux', 05:44:15 INFO - 'TMOUT': '86400', 05:44:15 INFO - 'USER': 'cltbld', 05:44:15 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1462884241.694061-1217471790', 05:44:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:15 INFO - '_': '/tools/buildbot/bin/python'} 05:44:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:16 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:44:16 INFO - Cleaning up... 05:44:16 INFO - Return code: 0 05:44:16 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:44:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:16 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 0x7f622143df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2010770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209f9c0>, '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 0x20a08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a0d50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1462884241.694061-1217471790', '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:44:16 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:44:16 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:44:16 INFO - Using env: {'DISPLAY': ':0', 05:44:16 INFO - 'HOME': '/home/cltbld', 05:44:16 INFO - 'LANG': 'en_US.UTF-8', 05:44:16 INFO - 'LANGUAGE': 'en_US:en', 05:44:16 INFO - 'LOGNAME': 'cltbld', 05:44:16 INFO - 'MAIL': '/var/mail/cltbld', 05:44:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:16 INFO - 'MOZ_NO_REMOTE': '1', 05:44:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:16 INFO - 'NO_EM_RESTART': '1', 05:44:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:44:16 INFO - 'PWD': '/builds/slave/test', 05:44:16 INFO - 'SHELL': '/bin/bash', 05:44:16 INFO - 'SHLVL': '1', 05:44:16 INFO - 'TERM': 'linux', 05:44:16 INFO - 'TMOUT': '86400', 05:44:16 INFO - 'USER': 'cltbld', 05:44:16 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1462884241.694061-1217471790', 05:44:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:16 INFO - '_': '/tools/buildbot/bin/python'} 05:44:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:16 INFO - Downloading/unpacking psutil>=0.7.1 05:44:16 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:44:16 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:44:16 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:44:16 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:44:16 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:44:16 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:44:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:44:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:44:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:44:18 INFO - Installing collected packages: psutil 05:44:18 INFO - Running setup.py install for psutil 05:44:18 INFO - building 'psutil._psutil_linux' extension 05:44:18 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:44:18 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:44:18 INFO - building 'psutil._psutil_posix' extension 05:44:18 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:44:18 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:44:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:44:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:44:18 INFO - Successfully installed psutil 05:44:18 INFO - Cleaning up... 05:44:18 INFO - Return code: 0 05:44:18 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:44:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:18 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 0x7f622143df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2010770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209f9c0>, '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 0x20a08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a0d50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1462884241.694061-1217471790', '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:44:18 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:44:18 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:44:18 INFO - Using env: {'DISPLAY': ':0', 05:44:18 INFO - 'HOME': '/home/cltbld', 05:44:18 INFO - 'LANG': 'en_US.UTF-8', 05:44:18 INFO - 'LANGUAGE': 'en_US:en', 05:44:18 INFO - 'LOGNAME': 'cltbld', 05:44:18 INFO - 'MAIL': '/var/mail/cltbld', 05:44:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:18 INFO - 'MOZ_NO_REMOTE': '1', 05:44:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:18 INFO - 'NO_EM_RESTART': '1', 05:44:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:44:18 INFO - 'PWD': '/builds/slave/test', 05:44:18 INFO - 'SHELL': '/bin/bash', 05:44:18 INFO - 'SHLVL': '1', 05:44:18 INFO - 'TERM': 'linux', 05:44:18 INFO - 'TMOUT': '86400', 05:44:18 INFO - 'USER': 'cltbld', 05:44:18 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1462884241.694061-1217471790', 05:44:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:18 INFO - '_': '/tools/buildbot/bin/python'} 05:44:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:19 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:44:19 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:44:19 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:44:19 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:44:19 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:44:19 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:44:19 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:44:21 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:44:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:44:21 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:44:21 INFO - Installing collected packages: mozsystemmonitor 05:44:21 INFO - Running setup.py install for mozsystemmonitor 05:44:21 INFO - Successfully installed mozsystemmonitor 05:44:21 INFO - Cleaning up... 05:44:21 INFO - Return code: 0 05:44:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:44:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:21 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 0x7f622143df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2010770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209f9c0>, '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 0x20a08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a0d50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1462884241.694061-1217471790', '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:44:21 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:44:21 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:44:21 INFO - Using env: {'DISPLAY': ':0', 05:44:21 INFO - 'HOME': '/home/cltbld', 05:44:21 INFO - 'LANG': 'en_US.UTF-8', 05:44:21 INFO - 'LANGUAGE': 'en_US:en', 05:44:21 INFO - 'LOGNAME': 'cltbld', 05:44:21 INFO - 'MAIL': '/var/mail/cltbld', 05:44:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:21 INFO - 'MOZ_NO_REMOTE': '1', 05:44:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:21 INFO - 'NO_EM_RESTART': '1', 05:44:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:44:21 INFO - 'PWD': '/builds/slave/test', 05:44:21 INFO - 'SHELL': '/bin/bash', 05:44:21 INFO - 'SHLVL': '1', 05:44:21 INFO - 'TERM': 'linux', 05:44:21 INFO - 'TMOUT': '86400', 05:44:21 INFO - 'USER': 'cltbld', 05:44:21 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1462884241.694061-1217471790', 05:44:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:21 INFO - '_': '/tools/buildbot/bin/python'} 05:44:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:21 INFO - Downloading/unpacking blobuploader==1.2.4 05:44:21 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:44:21 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:44:21 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:44:21 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:44:21 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:44:21 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:44:23 INFO - Downloading blobuploader-1.2.4.tar.gz 05:44:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:44:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:44:23 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:44:23 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:44:23 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:44:23 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:44:23 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:44:23 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:44:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:44:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:44:23 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:44:23 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:44:23 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:44:23 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:44:23 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:44:23 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:44:24 INFO - Downloading docopt-0.6.1.tar.gz 05:44:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:44:24 INFO - Installing collected packages: blobuploader, requests, docopt 05:44:24 INFO - Running setup.py install for blobuploader 05:44:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:44:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:44:24 INFO - Running setup.py install for requests 05:44:24 INFO - Running setup.py install for docopt 05:44:24 INFO - Successfully installed blobuploader requests docopt 05:44:24 INFO - Cleaning up... 05:44:24 INFO - Return code: 0 05:44:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:44:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:24 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 0x7f622143df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2010770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209f9c0>, '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 0x20a08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a0d50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1462884241.694061-1217471790', '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:44:24 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:44:24 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:44:24 INFO - Using env: {'DISPLAY': ':0', 05:44:24 INFO - 'HOME': '/home/cltbld', 05:44:24 INFO - 'LANG': 'en_US.UTF-8', 05:44:24 INFO - 'LANGUAGE': 'en_US:en', 05:44:24 INFO - 'LOGNAME': 'cltbld', 05:44:24 INFO - 'MAIL': '/var/mail/cltbld', 05:44:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:24 INFO - 'MOZ_NO_REMOTE': '1', 05:44:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:24 INFO - 'NO_EM_RESTART': '1', 05:44:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:44:24 INFO - 'PWD': '/builds/slave/test', 05:44:24 INFO - 'SHELL': '/bin/bash', 05:44:24 INFO - 'SHLVL': '1', 05:44:24 INFO - 'TERM': 'linux', 05:44:24 INFO - 'TMOUT': '86400', 05:44:24 INFO - 'USER': 'cltbld', 05:44:24 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1462884241.694061-1217471790', 05:44:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:24 INFO - '_': '/tools/buildbot/bin/python'} 05:44:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:44:24 INFO - Running setup.py (path:/tmp/pip-KOxZbe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:44:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:44:24 INFO - Running setup.py (path:/tmp/pip-8NKLPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:44:25 INFO - Running setup.py (path:/tmp/pip-9pbJvF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:44:25 INFO - Running setup.py (path:/tmp/pip-UA60l1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:44:25 INFO - Running setup.py (path:/tmp/pip-AQXqPO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:44:25 INFO - Running setup.py (path:/tmp/pip-iftgT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:44:25 INFO - Running setup.py (path:/tmp/pip-EgCJ2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:44:25 INFO - Running setup.py (path:/tmp/pip-PGxRwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:44:25 INFO - Running setup.py (path:/tmp/pip-8MPeLB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:44:25 INFO - Running setup.py (path:/tmp/pip-OrJnsh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:44:25 INFO - Running setup.py (path:/tmp/pip-UHt50r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:44:25 INFO - Running setup.py (path:/tmp/pip-12vlFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:44:25 INFO - Running setup.py (path:/tmp/pip-8uX5kg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:44:25 INFO - Running setup.py (path:/tmp/pip-Uy9_l4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:44:25 INFO - Running setup.py (path:/tmp/pip-bLvGys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:44:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:44:25 INFO - Running setup.py (path:/tmp/pip-bQMb3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:44:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:44:26 INFO - Running setup.py (path:/tmp/pip-9gR53i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:44:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:44:26 INFO - Running setup.py install for manifestparser 05:44:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:44:26 INFO - Running setup.py install for mozcrash 05:44:26 INFO - Running setup.py install for mozdebug 05:44:26 INFO - Running setup.py install for mozdevice 05:44:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:44:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:44:26 INFO - Running setup.py install for mozfile 05:44:26 INFO - Running setup.py install for mozhttpd 05:44:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:44:26 INFO - Running setup.py install for mozinfo 05:44:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:44:26 INFO - Running setup.py install for mozInstall 05:44:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:44:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:44:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:44:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:44:26 INFO - Running setup.py install for mozleak 05:44:26 INFO - Running setup.py install for mozlog 05:44:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:44:27 INFO - Running setup.py install for moznetwork 05:44:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:44:27 INFO - Running setup.py install for mozprocess 05:44:27 INFO - Running setup.py install for mozprofile 05:44:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:44:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:44:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:44:27 INFO - Running setup.py install for mozrunner 05:44:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:44:27 INFO - Running setup.py install for mozscreenshot 05:44:27 INFO - Running setup.py install for moztest 05:44:27 INFO - Running setup.py install for mozversion 05:44:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:44:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:44:27 INFO - Cleaning up... 05:44:27 INFO - Return code: 0 05:44:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:44:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:27 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 0x7f622143df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2010770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209f9c0>, '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 0x20a08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a0d50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1462884241.694061-1217471790', '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:44:27 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:44:27 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:44:27 INFO - Using env: {'DISPLAY': ':0', 05:44:27 INFO - 'HOME': '/home/cltbld', 05:44:27 INFO - 'LANG': 'en_US.UTF-8', 05:44:27 INFO - 'LANGUAGE': 'en_US:en', 05:44:27 INFO - 'LOGNAME': 'cltbld', 05:44:27 INFO - 'MAIL': '/var/mail/cltbld', 05:44:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:27 INFO - 'MOZ_NO_REMOTE': '1', 05:44:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:27 INFO - 'NO_EM_RESTART': '1', 05:44:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:44:27 INFO - 'PWD': '/builds/slave/test', 05:44:27 INFO - 'SHELL': '/bin/bash', 05:44:27 INFO - 'SHLVL': '1', 05:44:27 INFO - 'TERM': 'linux', 05:44:27 INFO - 'TMOUT': '86400', 05:44:27 INFO - 'USER': 'cltbld', 05:44:27 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1462884241.694061-1217471790', 05:44:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:27 INFO - '_': '/tools/buildbot/bin/python'} 05:44:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:44:28 INFO - Running setup.py (path:/tmp/pip-siSZLR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:44:28 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:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:44:28 INFO - Running setup.py (path:/tmp/pip-gUGVr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:44:28 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:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:44:28 INFO - Running setup.py (path:/tmp/pip-d4Tm62-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:44:28 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:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:44:28 INFO - Running setup.py (path:/tmp/pip-0a9S7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:44:28 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:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:44:28 INFO - Running setup.py (path:/tmp/pip-W81pGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:44:28 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:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:44:28 INFO - Running setup.py (path:/tmp/pip-zTaTkA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:44:28 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:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:44:28 INFO - Running setup.py (path:/tmp/pip-6W7bSf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:44:28 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:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:44:28 INFO - Running setup.py (path:/tmp/pip-AdrBe6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:44:28 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:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:44:28 INFO - Running setup.py (path:/tmp/pip-nw7vX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:44:28 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:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:44:28 INFO - Running setup.py (path:/tmp/pip-KiQCL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:44:28 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:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:44:28 INFO - Running setup.py (path:/tmp/pip-tgNviB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:44:28 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:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:44:28 INFO - Running setup.py (path:/tmp/pip-Qb4F_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:44:28 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:44:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:44:28 INFO - Running setup.py (path:/tmp/pip-Jxhn8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:44:29 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:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:44:29 INFO - Running setup.py (path:/tmp/pip-HzG4E_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:44:29 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:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:44:29 INFO - Running setup.py (path:/tmp/pip-KCEvXO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:44:29 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:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:44:29 INFO - Running setup.py (path:/tmp/pip-gwnhr9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:44:29 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:44:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:44:29 INFO - Running setup.py (path:/tmp/pip-00Ygq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:44:29 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:44:29 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:44:29 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:44:29 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:44:29 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:44:29 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:44:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:44:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:31 INFO - Downloading blessings-1.6.tar.gz 05:44:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:44:31 INFO - Installing collected packages: blessings 05:44:31 INFO - Running setup.py install for blessings 05:44:31 INFO - Successfully installed blessings 05:44:31 INFO - Cleaning up... 05:44:31 INFO - Return code: 0 05:44:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:44:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:44:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:44:31 INFO - Reading from file tmpfile_stdout 05:44:31 INFO - Current package versions: 05:44:31 INFO - argparse == 1.2.1 05:44:31 INFO - blessings == 1.6 05:44:31 INFO - blobuploader == 1.2.4 05:44:31 INFO - docopt == 0.6.1 05:44:31 INFO - manifestparser == 1.1 05:44:31 INFO - mozInstall == 1.12 05:44:31 INFO - mozcrash == 0.17 05:44:31 INFO - mozdebug == 0.1 05:44:31 INFO - mozdevice == 0.48 05:44:31 INFO - mozfile == 1.2 05:44:31 INFO - mozhttpd == 0.7 05:44:31 INFO - mozinfo == 0.9 05:44:31 INFO - mozleak == 0.1 05:44:31 INFO - mozlog == 3.1 05:44:31 INFO - moznetwork == 0.27 05:44:31 INFO - mozprocess == 0.22 05:44:31 INFO - mozprofile == 0.28 05:44:31 INFO - mozrunner == 6.11 05:44:31 INFO - mozscreenshot == 0.1 05:44:31 INFO - mozsystemmonitor == 0.0 05:44:31 INFO - moztest == 0.7 05:44:31 INFO - mozversion == 1.4 05:44:31 INFO - psutil == 3.1.1 05:44:31 INFO - requests == 1.2.3 05:44:31 INFO - wsgiref == 0.1.2 05:44:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:44:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:31 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 0x7f622143df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2010770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209f9c0>, '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 0x20a08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a0d50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1462884241.694061-1217471790', '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:44:31 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:44:31 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:44:31 INFO - Using env: {'DISPLAY': ':0', 05:44:31 INFO - 'HOME': '/home/cltbld', 05:44:31 INFO - 'LANG': 'en_US.UTF-8', 05:44:31 INFO - 'LANGUAGE': 'en_US:en', 05:44:31 INFO - 'LOGNAME': 'cltbld', 05:44:31 INFO - 'MAIL': '/var/mail/cltbld', 05:44:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:31 INFO - 'MOZ_NO_REMOTE': '1', 05:44:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:31 INFO - 'NO_EM_RESTART': '1', 05:44:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:44:31 INFO - 'PWD': '/builds/slave/test', 05:44:31 INFO - 'SHELL': '/bin/bash', 05:44:31 INFO - 'SHLVL': '1', 05:44:31 INFO - 'TERM': 'linux', 05:44:31 INFO - 'TMOUT': '86400', 05:44:31 INFO - 'USER': 'cltbld', 05:44:31 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1462884241.694061-1217471790', 05:44:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:31 INFO - '_': '/tools/buildbot/bin/python'} 05:44:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:31 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:44:31 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:44:31 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:44:31 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:44:31 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:44:31 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:44:31 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:44:31 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:44:31 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:44:31 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:44:31 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:44:31 INFO - Cleaning up... 05:44:31 INFO - Return code: 0 05:44:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:44:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:44:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f622143df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2010770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209f9c0>, '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 0x20a08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a0d50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1462884241.694061-1217471790', '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:44:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:44:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:44:31 INFO - Using env: {'DISPLAY': ':0', 05:44:31 INFO - 'HOME': '/home/cltbld', 05:44:31 INFO - 'LANG': 'en_US.UTF-8', 05:44:31 INFO - 'LANGUAGE': 'en_US:en', 05:44:31 INFO - 'LOGNAME': 'cltbld', 05:44:31 INFO - 'MAIL': '/var/mail/cltbld', 05:44:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:31 INFO - 'MOZ_NO_REMOTE': '1', 05:44:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:31 INFO - 'NO_EM_RESTART': '1', 05:44:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:44:31 INFO - 'PWD': '/builds/slave/test', 05:44:31 INFO - 'SHELL': '/bin/bash', 05:44:31 INFO - 'SHLVL': '1', 05:44:31 INFO - 'TERM': 'linux', 05:44:31 INFO - 'TMOUT': '86400', 05:44:31 INFO - 'USER': 'cltbld', 05:44:31 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1462884241.694061-1217471790', 05:44:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:31 INFO - '_': '/tools/buildbot/bin/python'} 05:44:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:32 INFO - Downloading/unpacking jsonschema 05:44:32 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:44:32 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:44:32 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:44:32 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:44:32 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:44:32 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:44:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:44:33 INFO - Downloading/unpacking functools32 (from jsonschema) 05:44:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:34 INFO - Downloading functools32-3.2.3-2.tar.gz 05:44:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:44:34 INFO - warning: no files found matching '*.txt' 05:44:34 INFO - no previously-included directories found matching 'build' 05:44:34 INFO - no previously-included directories found matching 'dist' 05:44:34 INFO - no previously-included directories found matching '.git*' 05:44:34 INFO - Installing collected packages: jsonschema, functools32 05:44:34 INFO - Running setup.py install for functools32 05:44:34 INFO - warning: no files found matching '*.txt' 05:44:34 INFO - no previously-included directories found matching 'build' 05:44:34 INFO - no previously-included directories found matching 'dist' 05:44:34 INFO - no previously-included directories found matching '.git*' 05:44:34 INFO - Successfully installed jsonschema functools32 05:44:34 INFO - Cleaning up... 05:44:34 INFO - Return code: 0 05:44:34 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:44: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:44:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:44:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44: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:44:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:44:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:44:34 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 0x7f622143df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f458a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2010770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209f9c0>, '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 0x20a08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a0d50>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1462884241.694061-1217471790', '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:44:34 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:44:34 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:44:34 INFO - Using env: {'DISPLAY': ':0', 05:44:34 INFO - 'HOME': '/home/cltbld', 05:44:34 INFO - 'LANG': 'en_US.UTF-8', 05:44:34 INFO - 'LANGUAGE': 'en_US:en', 05:44:34 INFO - 'LOGNAME': 'cltbld', 05:44:34 INFO - 'MAIL': '/var/mail/cltbld', 05:44:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:34 INFO - 'MOZ_NO_REMOTE': '1', 05:44:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:34 INFO - 'NO_EM_RESTART': '1', 05:44:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:44:34 INFO - 'PWD': '/builds/slave/test', 05:44:34 INFO - 'SHELL': '/bin/bash', 05:44:34 INFO - 'SHLVL': '1', 05:44:34 INFO - 'TERM': 'linux', 05:44:34 INFO - 'TMOUT': '86400', 05:44:34 INFO - 'USER': 'cltbld', 05:44:34 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1462884241.694061-1217471790', 05:44:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:34 INFO - '_': '/tools/buildbot/bin/python'} 05:44:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:44:34 INFO - Downloading/unpacking flake8 05:44:34 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:44:34 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:44:34 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:44:34 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:44:34 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:44:34 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:44:36 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:44:36 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:44:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:36 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:44:36 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:44:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:37 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:44:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:44:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:44:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:44:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:44:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:44:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:44:37 INFO - no previously-included directories found matching 'docs/_build' 05:44:37 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:44:37 INFO - Running setup.py install for pep8 05:44:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:44:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:44:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:44:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:44:37 INFO - no previously-included directories found matching 'docs/_build' 05:44:37 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:44:37 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:44:37 INFO - Cleaning up... 05:44:37 INFO - Return code: 0 05:44:37 INFO - Running post-action listener: _resource_record_post_action 05:44:37 INFO - Running post-action listener: _start_resource_monitoring 05:44:37 INFO - Starting resource monitoring. 05:44:37 INFO - ##### 05:44:37 INFO - ##### Finished create-virtualenv step (success) 05:44:37 INFO - ##### 05:44:37 INFO - ##### 05:44:37 INFO - ##### Running install step. 05:44:37 INFO - ##### 05:44:37 INFO - Running pre-action listener: _resource_record_pre_action 05:44:37 INFO - Running main action method: install 05:44:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:44:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:44:37 INFO - Reading from file tmpfile_stdout 05:44:37 INFO - Detecting whether we're running mozinstall >=1.0... 05:44:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:44:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:44:38 INFO - Reading from file tmpfile_stdout 05:44:38 INFO - Output received: 05:44:38 INFO - Usage: mozinstall [options] installer 05:44:38 INFO - Options: 05:44:38 INFO - -h, --help show this help message and exit 05:44:38 INFO - -d DEST, --destination=DEST 05:44:38 INFO - Directory to install application into. [default: 05:44:38 INFO - "/builds/slave/test"] 05:44:38 INFO - --app=APP Application being installed. [default: firefox] 05:44:38 INFO - mkdir: /builds/slave/test/build/application 05:44:38 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:44:38 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:44:54 INFO - Reading from file tmpfile_stdout 05:44:54 INFO - Output received: 05:44:54 INFO - /builds/slave/test/build/application/firefox/firefox 05:44:54 INFO - Running post-action listener: _resource_record_post_action 05:44:54 INFO - ##### 05:44:54 INFO - ##### Finished install step (success) 05:44:54 INFO - ##### 05:44:54 INFO - ##### 05:44:54 INFO - ##### Running run-tests step. 05:44:54 INFO - ##### 05:44:54 INFO - Running pre-action listener: _resource_record_pre_action 05:44:54 INFO - Running main action method: run_tests 05:44:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:44:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:44:54 INFO - Python 2.7.3 05:44:54 INFO - Return code: 0 05:44:54 INFO - grabbing minidump binary from tooltool 05:44:54 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:44:54 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 0x209f9c0>, '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 0x20a08c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20a0d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:44:54 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:44:54 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:44:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:44:54 INFO - Return code: 0 05:44:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:44:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:44:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:44:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:44:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:44:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:44:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:44:55 INFO - Return code: 0 05:44:55 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/IaJYfo7WRPOaXE0JMlX2Eg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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:44:55 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/IaJYfo7WRPOaXE0JMlX2Eg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --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:44:55 INFO - Using env: {'DISPLAY': ':0', 05:44:55 INFO - 'HOME': '/home/cltbld', 05:44:55 INFO - 'LANG': 'en_US.UTF-8', 05:44:55 INFO - 'LANGUAGE': 'en_US:en', 05:44:55 INFO - 'LOGNAME': 'cltbld', 05:44:55 INFO - 'MAIL': '/var/mail/cltbld', 05:44:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:44:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:44:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:44:55 INFO - 'MOZ_NO_REMOTE': '1', 05:44:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:44:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:44:55 INFO - 'NO_EM_RESTART': '1', 05:44:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:44:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:44:55 INFO - 'PWD': '/builds/slave/test', 05:44:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:44:55 INFO - 'SHELL': '/bin/bash', 05:44:55 INFO - 'SHLVL': '1', 05:44:55 INFO - 'TERM': 'linux', 05:44:55 INFO - 'TMOUT': '86400', 05:44:55 INFO - 'USER': 'cltbld', 05:44:55 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1462884241.694061-1217471790', 05:44:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:44:55 INFO - '_': '/tools/buildbot/bin/python'} 05:44:55 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/IaJYfo7WRPOaXE0JMlX2Eg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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:44:55 INFO - mozversion application_buildid: 20160510030240 05:44:55 INFO - mozversion application_changeset: 043082cb7bd8490c60815f67fbd1f33323ad7663 05:44:55 INFO - mozversion application_display_name: Nightly 05:44:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:44:55 INFO - mozversion application_name: Firefox 05:44:55 INFO - mozversion application_remotingname: firefox 05:44:55 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:44:55 INFO - mozversion application_vendor: Mozilla 05:44:55 INFO - mozversion application_version: 49.0a1 05:44:55 INFO - mozversion platform_buildid: 20160510030240 05:44:55 INFO - mozversion platform_changeset: 043082cb7bd8490c60815f67fbd1f33323ad7663 05:44:55 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:44:55 INFO - mozversion platform_version: 49.0a1 05:44:55 INFO - using testdate: 1462884295 05:44:55 INFO - actual date: 1462884295 05:44:55 INFO - starting webserver on 'localhost:59414' 05:44:55 INFO - SUITE-START | Running 2 tests 05:44:55 INFO - TEST-START | dromaeo_css 05:44:55 INFO - operating with platform_type : linux_ 05:44:55 INFO - Initialising browser for dromaeo_css test... 05:44:55 INFO - TEST-INFO | started process 14931 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5yvYJ2/profile http://localhost:59414/getInfo.html) 05:45:01 INFO - PROCESS | 14931 | __metrics Screen width/height:1600/1200 05:45:01 INFO - PROCESS | 14931 | colorDepth:24 05:45:01 INFO - PROCESS | 14931 | Browser inner width/height: 1024/697 05:45:01 INFO - PROCESS | 14931 | __metrics 05:45:02 ERROR - PROCESS | 14931 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:45:03 INFO - TEST-INFO | 14931: exit 0 05:45:03 INFO - Browser initialized. 05:45:03 INFO - Running cycle 1/1 for dromaeo_css test... 05:45:03 INFO - TEST-INFO | started process 15011 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5yvYJ2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:45:15 INFO - PROCESS | 15011 | RSS: Main: 152199168 05:45:15 INFO - PROCESS | 15011 | 05:46:06 INFO - PROCESS | 15011 | 1462884366674 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] 05:48:14 INFO - PROCESS | 15011 | Cycle 1(1): loaded http://localhost:59414/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59414/tests/dromaeo/cssquery-ext.html) 05:48:15 INFO - PROCESS | 15011 | RSS: Main: 256380928 05:48:15 INFO - PROCESS | 15011 | 05:51:18 INFO - PROCESS | 15011 | Cycle 1(1): loaded http://localhost:59414/tests/dromaeo/cssquery-ext.html (next: http://localhost:59414/tests/dromaeo/cssquery-jquery.html) 05:51:18 INFO - PROCESS | 15011 | RSS: Main: 241291264 05:51:18 INFO - PROCESS | 15011 | 05:54:20 INFO - PROCESS | 15011 | Cycle 1(1): loaded http://localhost:59414/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59414/tests/dromaeo/cssquery-mootools.html) 05:54:21 INFO - PROCESS | 15011 | RSS: Main: 232964096 05:54:21 INFO - PROCESS | 15011 | 05:57:23 INFO - PROCESS | 15011 | Cycle 1(1): loaded http://localhost:59414/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59414/tests/dromaeo/cssquery-prototype.html) 05:57:23 INFO - PROCESS | 15011 | RSS: Main: 225824768 05:57:23 INFO - PROCESS | 15011 | 06:00:26 INFO - PROCESS | 15011 | Cycle 1(1): loaded http://localhost:59414/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59414/tests/dromaeo/cssquery-yui.html) 06:00:27 INFO - PROCESS | 15011 | RSS: Main: 203259904 06:00:27 INFO - PROCESS | 15011 | 06:03:29 INFO - PROCESS | 15011 | Cycle 1(1): loaded http://localhost:59414/tests/dromaeo/cssquery-yui.html (next: http://localhost:59414/tests/dromaeo/cssquery-dojo.html) 06:03:29 INFO - PROCESS | 15011 | RSS: Main: 275517440 06:03:29 INFO - PROCESS | 15011 | 06:03:29 INFO - PROCESS | 15011 | __start_tp_report 06:03:29 INFO - PROCESS | 15011 | _x_x_mozilla_page_load 06:03:29 INFO - PROCESS | 15011 | _x_x_mozilla_page_load_details 06:03:29 INFO - PROCESS | 15011 | |i|pagename|runs| 06:03:29 INFO - PROCESS | 15011 | |0;dojo.html;3137.5764271823296;3140.7173354398105;3159.3049529103596;3182.347618738159;3200.1679563313533;5272.604554658402;5296.390915044771;5365.7585408656605;5369.677819330833;5398.514133727964;5325.121354976424;5330;5345.679259244448;5401.108817045193;5443.074677304858;4777.952220477794;4873.853784386474;4882.145624515713;4923.926141107886;5077.111505486543;4992.925106123393;5019.121653710605;5039.0425819094435;5061.746912654371;5063.392392912837;4771.952280477186;4815.7110573365535;4853.684510506841;4857.271409288635;4886.828960986366;4850.733209673466;4858.368412106439;4923.286123512106;4927.285543596195;4967.577755890754;4801.327814106028;4903.092927808331;4905.681130726492;4928.457869634337;4958.553730164266;5211.270422140903;5263.236830659571;5285.445028272053;5374.785008599691;5379.5427388671615;5756.280464941882;5774.769009239625;5805.10020946754;5825.475707186373;5826.9708651456895;5634.802781902655;5720.370759216483;5938.079597662369;5965.701714914237;5973.283206015262;5436.619436639437;5550.4449555044175;5559;5561.4716601923155;5563.109902415594;6023.939760602426;6067.605605635619;6075.210222671025;6082.57421980466;6085.4523092921845;5603.075492543766;5673.971630141823;5700.885982280414;5778.479936805707;5830.5627077968475;5885.6174348668055;5887.676177810176;5889.1755154278435;5894.587378883437;5938.584299099021;5819.941800582024;5861.9706901465215;5865.120231965239;5877.706114694333;5878.706064696748;5573.637713548606;5671.971640141773;5744.540436765049;5747.597668163188;5880.26496687914;4242.236397448427;4245.702800803976;4247.256730072225;4249.2563801334645;4277.486701595828;3817.866374676873;3822.445745366962;3843;3865.96134038656;3872.8644497442456;5323.467653234646;5442.836714898559;5496.093144631171;5527.50252477279;5559.138333558305;5904.852378690482;5913.349531551526;5922.911156332659;5924.911126333109;5931.614445061057;5290.391604965478;5537.640053396597;5553.916691249635;5561.555075593943;5564.304461942257;4843.927341089887;4873.829415970424;4889.657723959289;4930.975345123252;4945.109880221595;6086.878262434727;6089.786857459968;6091.329953705089;6092.786752463731;6101.755929762849;5666.914996275142;5683.119116536944;5906.940930590725;5918.141869428822;5930.614510056833;5906.557008224487;5964.31410387811;5969.074793406855;5975.970120149372;6025.789097381746;5625.831225063254;5670.064439367623;5681.261436013292;5682.545396368363;5688.260526131577;5694.088945768657;5705.714714264187;5781.103928891029;5786.189933409242;5801.129830525455;5700.429957004267;5709.172170035238;5716.199732037435;5716.256886604715;5751.194832723506;5636.267285252891;5655.4910058094965;5689.886202276014;5691.089425692035;5695.088785794253;5409.702466364388;5488.396276409512;5576.33084029919;5594.524465420485;5597.832065038056;5776.277965254343;5785.247917770663;5833.82498525045;5836.970815145897;5838.474537291664;5601.6358936668985;5652.717364131695;5660.660360378391;5661.264035675335;5699.51554117888 06:03:29 INFO - PROCESS | 15011 | |1;ext.html;606.2119244981526;625.1060982794602;643.478782186429;661.8444665503607;662.000379427065;43785;45221.32168017482;45321.374290056796;45337.54662453379;48383.758081209635;45098;45579.54420455795;45595.544044559545;45664.77167614165;45667.08665826682;9029.458232506055;9141.314401419886;9176.770580735501;9178.908210917905;9191.724248272563;8967.237784788302;9056.728298151065;9068.682596109138;9073.63705451781;9076.682316118937;9106.635734570642;9151.67969121081;9179;9189.035151309117;9204.953975230115;9118.772030699252;9137.497437640926;9142.72571822843;9166.450012999241;9167;8933.46399216049;9022.684206052756;9023.729288121302;9023.909760902372;9024.954875225581;42463.15073698509;42709.57290427118;42931.57068429307;42966.78516607428;43114;3552.6447355264268;3682.3371793077235;3758.624137586247;3861.710371722104;4284.507281662618;31865.84067079673;32926;33062.33875322504;33078.834605827054;33237.50143747846;4311.568843115695;4320.891977700551;4325.048489332374;4370.147821174872;4418.779061046935;311129;312111;313653;314135;314260;62329;62732.686336568026;62847;62870.37129628645;62936.37063629305;38922.41616375757;40026.59973400229;40048.59951400507;40122.79938600347;40160.59839401627;17183;17284;17389.130543472776;17396.565085872702;17400.825991740174;13010.414531345923;13186.802197967038;13190.076694631476;13197.406116724771;13205;20039.094331321878;20148.798512014986;20193.495162621053;20293.492662683257;20356.18575257003;6904;6915.273896240923;7034.859302814018;7157.642117894085;7286.635668216674;1027.814993301213;1106.3085571517802;1123.230587047875;1140.5551834784442;1143.0284258380311;31756.206094847814;31956.360872782414;31996.20009499781;32486.187845304055;32786.836065819516;1075.8977897099762;1169.3977601535216;1179.2511755035443;1188.7979043562616;1223.1621339382552;17596.29614815393;17665.55836104082;18243.5681952272;18380.724289135673;18849.24603015864;479051;481957;482452;482996;483800;57447;58856;58876.11685824716;58895.41104588899;58997;1282.1089342906591;1390.2075816784336;1395.4976208564908;1435.655442693746;1440.1862947434875;31126;32733.34533309273;32937;32987;33627.32745345031;49911.75044124756;50840;50927.49072509228;50950.49049509457;50963;363762;373898;374172;375128.7461376163;375697;25740.871295643403;27714.584281235395;28488.715112848608;28693.713062869938;30745.846270768503;47002.29496557486;47707.28439073486;48055.279170811766;48314.275285871445;48983.51016489932;39450;39837.80081099576;40375.59624403718;40546;40934.1813163741;39579.208415830944;39883.80058099691;39942.20115597614;40445.59554404418;40860;39717.404238937015;40731.796341018104;40764.1847163061;40776.3883541753;41025.79487102546;34620.65379346275;35667.286654267285;35850.641493585776;36495.45256821203;36720.898373048854;27663;27668.8616556924;27837.582436263066;27900.441991160467;27964.80527920828 06:03:29 INFO - PROCESS | 15011 | |2;jquery.html;389.30509041361177;400.8857475619445;401.24966312994695;411.3131071111242;415.22560424807745;17697.380591679295;18162.818371816276;19105.52236194096;19139.71290430643;19232;17508.387206447776;18173.90913045436;18320.63358732828;18388.540286492844;18490;5562.276904002474;5595.804146854861;5792.623479473821;5798.594098413113;5803.158542011406;5249.921251181236;5308.283381743454;5315.335583052119;5328.973355133238;5339.813106541272;5247.842564723064;5277.683338999653;5279.5512381447625;5696.829095127132;5708.800191993281;5646;5666.886662266732;5682.857928551778;5700.144978253254;5703.828885133432;4916.385451818523;5080.771365288534;5248.396434410053;5260.684358938438;5294.285271488338;13296.534621288209;13764.65588360289;13861.514846980308;13904.58286251414;13925.025248232629;2112.4402033461147;2210.149092599345;2231.3975226688704;2282.874441905711;2326.441654003044;9717.757056073584;9792.510374481319;10148.188144948386;10195.388276703421;10238.7440313992;1813.9274429022823;1913.425972208346;1927.7902292682666;1938.370029740326;1943.4364034429998;60919.69540152271;76491.23508764897;78681.60659196724;82585.39316854638;86816;10363.222758293008;10401.947990260152;10679.57281708723;10966.093985093798;10979.39613321275;13556.254406007763;15771.526854194393;15775.763363549557;15778.763318550002;15806.972546784422;7462.70149194037;7774.689012439552;7967.681292748225;8043.758687239275;8143.389245806588;7782;7909.3277071449575;7967.681292748341;8118.3099436548555;8133.146019667968;4756.904861902812;4825.782839772219;4851.466338702739;4853.563179313879;4903.436104847917;1870.7755069391487;1873.3536929759211;1885.264746748769;1934.4970307720093;1963.2834015584208;881.5195718333524;968.3415277611151;1015.5582321690089;1027.0551092994463;1060.9469526523797;18026.459206223833;18261.360852370104;18424.35514757004;18520.16659250337;18764.437066888015;988.7280997725683;1019.8980101989741;1025.3335332034237;1064.1114669251108;1080.2762149359949;9060.275177985744;10393.37639741618;10452.320599161183;10486;10504.579816807394;482422;495710;496258;498652;502296;50615.49384506108;60294.39705602975;66838;76666;89562.55218723995;1023.6468418395641;1048.2295512798087;1061.888501707325;1071.8552995345528;1076.9084627806567;16336.264868080727;16629.50111496657;16667.16664166811;16812.24344904507;17028.14859257057;39213.80393098016;39505.407418889314;41097.38353924634;41722;42035.7898210507;53757.73121134526;56499.43500565106;56928;57140.42859571517;57568.424315757984;8034.558099304594;8592.3555733319;8733.30133589324;8744;8832.602532885907;12011.399430028638;12061.698457538632;12546.435410406371;12715.93642031784;12718.300493472947;11169;11242.325460472397;11285.605003824827;11360.54557817678;11391.829122563335;8980.86528702057;10644.148468122377;10783.784324313312;11194.384308863091;11382.886171138183;11125.109991200847;11191.384473854016;11320.150988676047;11500.884991150317;11750.236234645063;8499.065102838806;8528.658853645784;8635.093315202064;8643.654253829776;8795.032546420016;8588.355873309401;10437.32157409766;10998.06516446111;11098.334099954029;11665.308530263233 06:03:29 INFO - PROCESS | 15011 | |3;mootools.html;1343.67080065384;1476.1512130524948;1539.6150962259435;1643.7698722178898;1770.9734353984684;7970.601469926502;8250.174982501754;8297.958510207449;8492.617832197551;8505.532195729233;8293.91706082939;8453.281471074966;8473.78815529612;8476.745697629065;8478.957605211965;2037.8573499855015;2087.5824835032977;2091.435312465633;2298.5173113646156;2319.3621754017613;2288.9084436622516;2376.2989917974237;2379.9048038078454;2391.485830546432;2398.784109430151;2321.872297023663;2361.775631315022;2372.323887692008;2387.2241521505493;2390.270967354956;2023.6660950943076;2099.0554250587297;2324.4537533679572;2355.3051849704293;2361.409647588103;2262.7058482397347;2319.4665226997886;2330.0330362899545;2335.1826860598826;2342.355852140658;8287.792805179859;8362.749117526484;8465;8465.915340846574;8488.575571221414;5108.540231379194;5222.503862133091;5228.137357336035;5254.553362964152;5262.447443018466;3331.4003479373705;3388.8983330500123;3498.912527186815;3511.262634846685;3534.7525673202886;1119.5297974850582;1124.2579897267765;1149.109440183864;1169.3685409878656;1173.8297946797752;11989.280643161352;11998.820017699742;12006.519739210422;12030.218035827644;12058.276503409823;4576.977115114403;4579.885502862388;4657.184992626277;4659.2312268476;4710.788014539354;9896.55465504054;9954.701358959099;9972.850407243897;9975.800483990279;9994.600215991424;5227.032998895141;5243.737813109329;5273.525382715574;5290;5294.100002999422;4379.496357918816;4641.118187544355;4737.6683632146105;4797.328374027639;4900.558949694545;3904.921901561953;3953.6755187012673;4007.8196481158416;4026.6376026157786;4033.032072302685;1255.8869701726887;1257.5158563952943;1274.5156840400773;1284.3064745037761;1289.1491615533703;996.3324572536418;998.1515711645188;1000.3797645459862;1001.1940387987739;1011.7420057885192;5705.372409035002;5722.456366645162;5837.845376795073;5869;6016.308124565643;446.8659402179333;449.05922093215315;450.7633492416442;1035.77213013137;1050.8003479339054;4139.172165566899;4174.853880114181;4196.51740049892;4203.684723645739;4237.809298581571;10594.417307048187;10958.28771129874;10997.395143267197;11053.447327633587;11141.275817071864;10765.439011343311;10931.672049838518;10967.83548246777;10990.725231869268;11014.229003969805;7815.101263354787;7869.527828330319;8007.559584222924;8124.512529248264;8152.2255385739445;5331.333583302087;5556.38879723222;5561.694106824163;5611.831645050655;5718.1708652246025;9844.901550984685;9969.102780749767;10137.442440665835;10171.13545348624;10332.17342612574;10317.071463568314;10318.329308594917;10355;10359.896401036194;10464.162866970471;7083.327083927019;7394;7573.810654733676;7780.144184139627;7968.402369822171;8327.54198519063;8330.291925186184;8395.70615028471;8406.28546573548;8429.325653947792;7398.297161769623;7612.961935190288;7629.46593738433;7685.961570192113;7722.189170137055;7397.4082073435075;7478.5138965967035;7492.400607951242;7607.543547387175;7635.847283054197;6915.89626155598;6957.4086202671315;6962.582245065312;6989.30106989297;6994.33553812387;4725.40932383452;4883.536064073907;4896.338994235733;4926.211806111005;4950.975245123751;4950.183219768698;5004.97398033395;5009.398872135367;5122.769475373691;5137.383513978347 06:03:29 INFO - PROCESS | 15011 | |4;prototype.html;329.6839701099774;343.64432812039536;346.5460247076332;348.4807636621435;349.04536093783514;5150.587952963763;5236.7905283788605;5307.442718514559;5399.568034557241;5403.7027963462;5281.128613778722;5313.282706834586;5315.627906046579;5320.898245193146;5333.679979201241;4141.088960428701;4212.368144778277;4225.366195070748;4227.85202517912;4235.491740991085;3991.900202494932;4056.655184309337;4185.518665353477;4204.516480604724;4237.322028475444;4129.256733787917;4148.0874207674415;4148.834046638146;4149.502059752834;4178.456800615931;4136.710430269883;4140.8136633851545;4141.233871733739;4150.896227594304;4150.958490415118;3465.4455287154187;3682.760620559655;3697.9445308320396;3701.5188025556504;3723.2181241939224;5136.74316284188;5145.202493613496;5145.3568303962;5170.767315470813;5208.9739551302;4761;4774.777025507803;4777.713337199744;4777.761111944424;4779.402574678165;5415.729213539307;5479.0959491683825;5579.776808927638;5595.776168953237;5618.63478873876;3985.7608543487486;4013.177298653769;4017.4332010515923;4039.5758445363404;4040.1919616076902;5722.856928576777;5779.855503612402;5790.594658373873;5791.509650850133;5849.415058494116;3966.147278335172;4062.192324415607;4071.877843664695;4079.4288799568085;4080.1431699342875;4155.127423241092;4175.31107367287;4182;4191.805335479435;4203.684723645739;4743.762811859393;4752.714837109785;4753.168195565762;4756.691909724854;4759.595434388116;5352.518273355417;5600.243967064394;5622;5629.915551266734;5643.971780141073;1369.869862363074;1386.3484162443635;1389.3817251323267;1398.7971744097254;1415.2004117673482;942.0014784328633;966.3089593211879;969.413504829582;969.7963427680126;975.7902051059057;5113.41195762492;5241.0828105081455;5274.756025044647;5277.8416647500635;5329.9467005330225;5432.837014889559;5460.235567020621;5462.317210348707;5524.640898341675;5539.41836107211;5040.420351659606;5109.514596113363;5194.766235519411;5250.501202385767;5293.497117773805;2931.6188895443456;2956.713829484181;2959.8604537253314;2962.333474968115;2985.7611391088662;5762.0985074925175;5770.019096753562;5792.536597072224;5849.707514624251;5858;5424.972875135599;5629;5631.662100273997;5640.774369025193;5641.153826925994;5560.165975103686;5724.856878577985;5727.713614319267;5777.740001699934;5801.361850196475;5399.379071406838;5552;5599.972000139973;5616.466435688603;5663.830085097289;5594.41258667834;5613.298337707786;5637.830865074055;5651.547876169979;5679.687617180929;5898.428717743783;5935.5548333875995;5940.6435613863305;5954.3152537458745;5983.311919129356;3961.8613348532663;4006.198760247904;4229.302165142717;4232.830686772618;4236.957630423656;5678.858028549319;5684.015891656748;5703.5722320826935;5707.600467967202;5720.971395142998;5564.666120032811;5572.888542229051;5577.860553486195;5614.2701448811395;5635.6618602883955;5328.946710532845;5559.9444005561045;5580.888382232251;5590.357108932525;5622.297212848394;5478.671279723229;5487.176923461513;5520.861978450571;5556.972215138899;5589.77640894376;5329.413764485826;5607.439256074523;5609.467100625434;5676.574256930664;5708.229389032427;5438.646487978269;5460.535854452416;5486.286782718381;5505.807296744595;5528.778848846001 06:03:29 INFO - PROCESS | 15011 | |5;yui.html;757.7461550380622;823.4935514658484;859.6002858670719;866.6706651472443;866.8049688820013;13613.65965850853;14671.706565868677;14679.045862018975;14696;14718.779218311734;13138.474461021571;13138.93430532846;13159.078864479467;13178.472861085545;13181;696.5890124826351;821.4455242711161;825.0594322472386;840.9075001749802;842.7640260726976;832.5046597274642;836.9665213391457;839.9286060684849;840.9873851892227;841.8063845315551;876.2551830943711;878.5168157513374;878.6661068793882;878.8813510176141;879.1033146190881;693.4937495628194;850.3834719828137;863.2230992107154;865.2861389353745;868.1535502884637;631.5610650597837;632.2855173653742;633.3887798274687;633.933436989114;634.3719717479707;13392.464301427932;13429.731405371935;13433.932830335785;13439.596812095653;13448.596542103753;13711.725765484734;13838.93080534601;13892.374843132084;13955.511557095453;13977;11926.642200733992;11946.940265298617;12062.939685301604;12145.210561313575;12441.75116497665;4515.345274935149;4523.32150177476;4547.375118680114;4560.24433088471;4659.767011649438;54258.18612720812;54454.72772636151;56007;56253.71873140649;56569.15146272768;10903;10920.563177472972;10922.402333286995;10939.179561532917;11051.447427628747;18821.15304811287;18835.340763073225;18837.434876953714;18841.717374239397;18847.24611015544;7866.331361834194;8071.636776345079;8227.958860205661;8319.084900660922;8399.664013439395;4582.793774280099;4665.4168228971375;4705.317728929286;4761.571458568746;4825.855224343275;3212.7751057425758;3258.9837050815067;3263.543103965447;3268.5587445695;3294.769366144395;669.1167658690579;672.0725398949419;687.1376422589618;690.1614538335946;713.400743375567;659.235287067;682.607500687107;804.2600807257337;806.3549160671439;822.7901885019281;10024.398536087858;10248.48757562119;10299.227557933185;10373.636922707668;10505.159587233004;760.4676278685475;779.9571023593757;782.7456076774957;784.3450718649877;815.2458975447687;4485.551444855489;4879.463259041502;4907.607391408679;4961.255811628284;4992.2511623256805;67250.32749672538;67297;68992.3100768996;69217.3078269221;70473;59359.70320148372;59830;60909;62488;63482.36517634857;55006.72496637491;55252.171217430965;55439;55689.164662529285;56120;8871.201591856763;8923.375363724737;8932.419392739452;8981.326400519856;9039.548022598976;35064.29871402507;35103;35126.473102902964;35411.99999999897;35760.10599735028;43951.34072988844;46227;48749;48759.512404875495;49955.75022124866;11079.169062320198;11290;11292.604758833402;11724.179307448398;11909.464074116513;12167.878321216675;12392.690182745142;12405.75188496243;12429.37853107323;12928.095033347952;11880.287182769061;11989.40052997364;11990.160688751703;12093;12211.87788122143;11577.6526704199;11914.940425297818;11943.10426718017;12239.082068844695;12388.62834114978;11551.364674942623;11600.18798684084;11763.235389699643;11812.40937953116;11888.643340699793;9678.509316770187;9862.852057219005;9927.205823534245;9956.950215248877;10151.137153342048;9926.900730992598;10069.496525173565;10086.344387614781;10142.645007424704;10155.187584993331 06:03:29 INFO - PROCESS | 15011 | __end_tp_report 06:03:29 INFO - PROCESS | 15011 | __start_cc_report 06:03:29 INFO - PROCESS | 15011 | _x_x_mozilla_cycle_collect,860 06:03:29 INFO - PROCESS | 15011 | __end_cc_report 06:03:29 INFO - PROCESS | 15011 | __startTimestamp1462885409959__endTimestamp 06:03:29 INFO - PROCESS | 15011 | 06:03:29 INFO - PROCESS | 15011 | ------- Summary: start ------- 06:03:29 INFO - PROCESS | 15011 | Number of tests: 6 06:03:29 INFO - PROCESS | 15011 | 06:03:29 INFO - PROCESS | 15011 | [#0] dojo.html Cycles:165 Average:5387.61 Median:5603.08 stddev:645.83 (11.5%) stddev-sans-first:623.22 06:03:29 INFO - PROCESS | 15011 | Values: 3137.6 3140.7 3159.3 3182.3 3200.2 5272.6 5296.4 5365.8 5369.7 5398.5 5325.1 5330.0 5345.7 5401.1 5443.1 4778.0 4873.9 4882.1 4923.9 5077.1 4992.9 5019.1 5039.0 5061.7 5063.4 4772.0 4815.7 4853.7 4857.3 4886.8 4850.7 4858.4 4923.3 4927.3 4967.6 4801.3 4903.1 4905.7 4928.5 4958.6 5211.3 5263.2 5285.4 5374.8 5379.5 5756.3 5774.8 5805.1 5825.5 5827.0 5634.8 5720.4 5938.1 5965.7 5973.3 5436.6 5550.4 5559.0 5561.5 5563.1 6023.9 6067.6 6075.2 6082.6 6085.5 5603.1 5674.0 5700.9 5778.5 5830.6 5885.6 5887.7 5889.2 5894.6 5938.6 5819.9 5862.0 5865.1 5877.7 5878.7 5573.6 5672.0 5744.5 5747.6 5880.3 4242.2 4245.7 4247.3 4249.3 4277.5 3817.9 3822.4 3843.0 3866.0 3872.9 5323.5 5442.8 5496.1 5527.5 5559.1 5904.9 5913.3 5922.9 5924.9 5931.6 5290.4 5537.6 5553.9 5561.6 5564.3 4843.9 4873.8 4889.7 4931.0 4945.1 6086.9 6089.8 6091.3 6092.8 6101.8 5666.9 5683.1 5906.9 5918.1 5930.6 5906.6 5964.3 5969.1 5976.0 6025.8 5625.8 5670.1 5681.3 5682.5 5688.3 5694.1 5705.7 5781.1 5786.2 5801.1 5700.4 5709.2 5716.2 5716.3 5751.2 5636.3 5655.5 5689.9 5691.1 5695.1 5409.7 5488.4 5576.3 5594.5 5597.8 5776.3 5785.2 5833.8 5837.0 5838.5 5601.6 5652.7 5660.7 5661.3 5699.5 06:03:29 INFO - PROCESS | 15011 | 06:03:29 INFO - PROCESS | 15011 | [#1] ext.html Cycles:180 Average:55724.66 Median:40410.60 stddev:104355.23 (258.2%) stddev-sans-first:104565.92 06:03:29 INFO - PROCESS | 15011 | Values: 606.2 625.1 643.5 661.8 662.0 43785.0 45221.3 45321.4 45337.5 48383.8 45098.0 45579.5 45595.5 45664.8 45667.1 9029.5 9141.3 9176.8 9178.9 9191.7 8967.2 9056.7 9068.7 9073.6 9076.7 9106.6 9151.7 9179.0 9189.0 9205.0 9118.8 9137.5 9142.7 9166.5 9167.0 8933.5 9022.7 9023.7 9023.9 9025.0 42463.2 42709.6 42931.6 42966.8 43114.0 3552.6 3682.3 3758.6 3861.7 4284.5 31865.8 32926.0 33062.3 33078.8 33237.5 4311.6 4320.9 4325.0 4370.1 4418.8 311129.0 312111.0 313653.0 314135.0 314260.0 62329.0 62732.7 62847.0 62870.4 62936.4 38922.4 40026.6 40048.6 40122.8 40160.6 17183.0 17284.0 17389.1 17396.6 17400.8 13010.4 13186.8 13190.1 13197.4 13205.0 20039.1 20148.8 20193.5 20293.5 20356.2 6904.0 6915.3 7034.9 7157.6 7286.6 1027.8 1106.3 1123.2 1140.6 1143.0 31756.2 31956.4 31996.2 32486.2 32786.8 1075.9 1169.4 1179.3 1188.8 1223.2 17596.3 17665.6 18243.6 18380.7 18849.2 479051.0 481957.0 482452.0 482996.0 483800.0 57447.0 58856.0 58876.1 58895.4 58997.0 1282.1 1390.2 1395.5 1435.7 1440.2 31126.0 32733.3 32937.0 32987.0 33627.3 49911.8 50840.0 50927.5 50950.5 50963.0 363762.0 373898.0 374172.0 375128.7 375697.0 25740.9 27714.6 28488.7 28693.7 30745.8 47002.3 47707.3 48055.3 48314.3 48983.5 39450.0 39837.8 40375.6 40546.0 40934.2 39579.2 39883.8 39942.2 40445.6 40860.0 39717.4 40731.8 40764.2 40776.4 41025.8 34620.7 35667.3 35850.6 36495.5 36720.9 27663.0 27668.9 27837.6 27900.4 27964.8 06:03:29 INFO - PROCESS | 15011 | 06:03:29 INFO - PROCESS | 15011 | [#2] jquery.html Cycles:180 Average:27803.60 Median:2304.66 stddev:81230.33 (3524.6%) stddev-sans-first:81432.12 06:03:29 INFO - PROCESS | 15011 | Values: 389.3 400.9 401.2 411.3 415.2 17697.4 18162.8 19105.5 19139.7 19232.0 17508.4 18173.9 18320.6 18388.5 18490.0 5562.3 5595.8 5792.6 5798.6 5803.2 5249.9 5308.3 5315.3 5329.0 5339.8 5247.8 5277.7 5279.6 5696.8 5708.8 5646.0 5666.9 5682.9 5700.1 5703.8 4916.4 5080.8 5248.4 5260.7 5294.3 13296.5 13764.7 13861.5 13904.6 13925.0 2112.4 2210.1 2231.4 2282.9 2326.4 9717.8 9792.5 10148.2 10195.4 10238.7 1813.9 1913.4 1927.8 1938.4 1943.4 60919.7 76491.2 78681.6 82585.4 86816.0 10363.2 10401.9 10679.6 10966.1 10979.4 13556.3 15771.5 15775.8 15778.8 15807.0 7462.7 7774.7 7967.7 8043.8 8143.4 7782.0 7909.3 7967.7 8118.3 8133.1 4756.9 4825.8 4851.5 4853.6 4903.4 1870.8 1873.4 1885.3 1934.5 1963.3 881.5 968.3 1015.6 1027.1 1060.9 18026.5 18261.4 18424.4 18520.2 18764.4 988.7 1019.9 1025.3 1064.1 1080.3 9060.3 10393.4 10452.3 10486.0 10504.6 482422.0 495710.0 496258.0 498652.0 502296.0 50615.5 60294.4 66838.0 76666.0 89562.6 1023.6 1048.2 1061.9 1071.9 1076.9 16336.3 16629.5 16667.2 16812.2 17028.1 39213.8 39505.4 41097.4 41722.0 42035.8 53757.7 56499.4 56928.0 57140.4 57568.4 8034.6 8592.4 8733.3 8744.0 8832.6 12011.4 12061.7 12546.4 12715.9 12718.3 11169.0 11242.3 11285.6 11360.5 11391.8 8980.9 10644.1 10783.8 11194.4 11382.9 11125.1 11191.4 11320.2 11500.9 11750.2 8499.1 8528.7 8635.1 8643.7 8795.0 8588.4 10437.3 10998.1 11098.3 11665.3 06:03:29 INFO - PROCESS | 15011 | 06:03:29 INFO - PROCESS | 15011 | [#3] mootools.html Cycles:180 Average:5704.22 Median:4658.21 stddev:3247.05 (69.7%) stddev-sans-first:3239.62 06:03:29 INFO - PROCESS | 15011 | Values: 1343.7 1476.2 1539.6 1643.8 1771.0 7970.6 8250.2 8298.0 8492.6 8505.5 8293.9 8453.3 8473.8 8476.7 8479.0 2037.9 2087.6 2091.4 2298.5 2319.4 2288.9 2376.3 2379.9 2391.5 2398.8 2321.9 2361.8 2372.3 2387.2 2390.3 2023.7 2099.1 2324.5 2355.3 2361.4 2262.7 2319.5 2330.0 2335.2 2342.4 8287.8 8362.7 8465.0 8465.9 8488.6 5108.5 5222.5 5228.1 5254.6 5262.4 3331.4 3388.9 3498.9 3511.3 3534.8 1119.5 1124.3 1149.1 1169.4 1173.8 11989.3 11998.8 12006.5 12030.2 12058.3 4577.0 4579.9 4657.2 4659.2 4710.8 9896.6 9954.7 9972.9 9975.8 9994.6 5227.0 5243.7 5273.5 5290.0 5294.1 4379.5 4641.1 4737.7 4797.3 4900.6 3904.9 3953.7 4007.8 4026.6 4033.0 1255.9 1257.5 1274.5 1284.3 1289.1 996.3 998.2 1000.4 1001.2 1011.7 5705.4 5722.5 5837.8 5869.0 6016.3 446.9 449.1 450.8 1035.8 1050.8 4139.2 4174.9 4196.5 4203.7 4237.8 10594.4 10958.3 10997.4 11053.4 11141.3 10765.4 10931.7 10967.8 10990.7 11014.2 7815.1 7869.5 8007.6 8124.5 8152.2 5331.3 5556.4 5561.7 5611.8 5718.2 9844.9 9969.1 10137.4 10171.1 10332.2 10317.1 10318.3 10355.0 10359.9 10464.2 7083.3 7394.0 7573.8 7780.1 7968.4 8327.5 8330.3 8395.7 8406.3 8429.3 7398.3 7613.0 7629.5 7686.0 7722.2 7397.4 7478.5 7492.4 7607.5 7635.8 6915.9 6957.4 6962.6 6989.3 6994.3 4725.4 4883.5 4896.3 4926.2 4951.0 4950.2 5005.0 5009.4 5122.8 5137.4 06:03:29 INFO - PROCESS | 15011 | 06:03:29 INFO - PROCESS | 15011 | [#4] prototype.html Cycles:180 Average:4670.30 Median:5324.92 stddev:1360.87 (25.6%) stddev-sans-first:1325.11 06:03:29 INFO - PROCESS | 15011 | Values: 329.7 343.6 346.5 348.5 349.0 5150.6 5236.8 5307.4 5399.6 5403.7 5281.1 5313.3 5315.6 5320.9 5333.7 4141.1 4212.4 4225.4 4227.9 4235.5 3991.9 4056.7 4185.5 4204.5 4237.3 4129.3 4148.1 4148.8 4149.5 4178.5 4136.7 4140.8 4141.2 4150.9 4151.0 3465.4 3682.8 3697.9 3701.5 3723.2 5136.7 5145.2 5145.4 5170.8 5209.0 4761.0 4774.8 4777.7 4777.8 4779.4 5415.7 5479.1 5579.8 5595.8 5618.6 3985.8 4013.2 4017.4 4039.6 4040.2 5722.9 5779.9 5790.6 5791.5 5849.4 3966.1 4062.2 4071.9 4079.4 4080.1 4155.1 4175.3 4182.0 4191.8 4203.7 4743.8 4752.7 4753.2 4756.7 4759.6 5352.5 5600.2 5622.0 5629.9 5644.0 1369.9 1386.3 1389.4 1398.8 1415.2 942.0 966.3 969.4 969.8 975.8 5113.4 5241.1 5274.8 5277.8 5329.9 5432.8 5460.2 5462.3 5524.6 5539.4 5040.4 5109.5 5194.8 5250.5 5293.5 2931.6 2956.7 2959.9 2962.3 2985.8 5762.1 5770.0 5792.5 5849.7 5858.0 5425.0 5629.0 5631.7 5640.8 5641.2 5560.2 5724.9 5727.7 5777.7 5801.4 5399.4 5552.0 5600.0 5616.5 5663.8 5594.4 5613.3 5637.8 5651.5 5679.7 5898.4 5935.6 5940.6 5954.3 5983.3 3961.9 4006.2 4229.3 4232.8 4237.0 5678.9 5684.0 5703.6 5707.6 5721.0 5564.7 5572.9 5577.9 5614.3 5635.7 5328.9 5559.9 5580.9 5590.4 5622.3 5478.7 5487.2 5520.9 5557.0 5589.8 5329.4 5607.4 5609.5 5676.6 5708.2 5438.6 5460.5 5486.3 5505.8 5528.8 06:03:29 INFO - PROCESS | 15011 | 06:03:29 INFO - PROCESS | 15011 | [#5] yui.html Cycles:180 Average:15334.40 Median:4733.44 stddev:18532.85 (391.5%) stddev-sans-first:18552.52 06:03:29 INFO - PROCESS | 15011 | Values: 757.7 823.5 859.6 866.7 866.8 13613.7 14671.7 14679.0 14696.0 14718.8 13138.5 13138.9 13159.1 13178.5 13181.0 696.6 821.4 825.1 840.9 842.8 832.5 837.0 839.9 841.0 841.8 876.3 878.5 878.7 878.9 879.1 693.5 850.4 863.2 865.3 868.2 631.6 632.3 633.4 633.9 634.4 13392.5 13429.7 13433.9 13439.6 13448.6 13711.7 13838.9 13892.4 13955.5 13977.0 11926.6 11946.9 12062.9 12145.2 12441.8 4515.3 4523.3 4547.4 4560.2 4659.8 54258.2 54454.7 56007.0 56253.7 56569.2 10903.0 10920.6 10922.4 10939.2 11051.4 18821.2 18835.3 18837.4 18841.7 18847.2 7866.3 8071.6 8228.0 8319.1 8399.7 4582.8 4665.4 4705.3 4761.6 4825.9 3212.8 3259.0 3263.5 3268.6 3294.8 669.1 672.1 687.1 690.2 713.4 659.2 682.6 804.3 806.4 822.8 10024.4 10248.5 10299.2 10373.6 10505.2 760.5 780.0 782.7 784.3 815.2 4485.6 4879.5 4907.6 4961.3 4992.3 67250.3 67297.0 68992.3 69217.3 70473.0 59359.7 59830.0 60909.0 62488.0 63482.4 55006.7 55252.2 55439.0 55689.2 56120.0 8871.2 8923.4 8932.4 8981.3 9039.5 35064.3 35103.0 35126.5 35412.0 35760.1 43951.3 46227.0 48749.0 48759.5 49955.8 11079.2 11290.0 11292.6 11724.2 11909.5 12167.9 12392.7 12405.8 12429.4 12928.1 11880.3 11989.4 11990.2 12093.0 12211.9 11577.7 11914.9 11943.1 12239.1 12388.6 11551.4 11600.2 11763.2 11812.4 11888.6 9678.5 9862.9 9927.2 9957.0 10151.1 9926.9 10069.5 10086.3 10142.6 10155.2 06:03:29 INFO - PROCESS | 15011 | -------- Summary: end -------- 06:03:29 INFO - PROCESS | 15011 | 06:03:30 INFO - TEST-INFO | 15011: exit 0 06:03:30 INFO - TEST-OK | dromaeo_css | took 1114963ms 06:03:30 INFO - TEST-START | kraken 06:03:30 INFO - operating with platform_type : linux_ 06:03:30 INFO - Initialising browser for kraken test... 06:03:30 INFO - TEST-INFO | started process 15196 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpobSGCB/profile http://localhost:59414/getInfo.html) 06:03:36 INFO - PROCESS | 15196 | __metrics Screen width/height:1600/1200 06:03:36 INFO - PROCESS | 15196 | colorDepth:24 06:03:36 INFO - PROCESS | 15196 | Browser inner width/height: 1024/697 06:03:36 INFO - PROCESS | 15196 | __metrics 06:03:37 ERROR - PROCESS | 15196 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:03:38 INFO - TEST-INFO | 15196: exit 0 06:03:38 INFO - Browser initialized. 06:03:38 INFO - Running cycle 1/1 for kraken test... 06:03:38 INFO - TEST-INFO | started process 15281 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpobSGCB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:03:50 INFO - PROCESS | 15281 | RSS: Main: 152363008 06:03:50 INFO - PROCESS | 15281 | 06:03:53 INFO - PROCESS | 15281 | Cycle 1(1): loaded http://localhost:59414/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59414/tests/kraken/driver.html?testName=audio-beat-detection) 06:03:53 INFO - PROCESS | 15281 | RSS: Main: 207884288 06:03:53 INFO - PROCESS | 15281 | 06:03:56 INFO - PROCESS | 15281 | Cycle 1(1): loaded http://localhost:59414/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59414/tests/kraken/driver.html?testName=audio-dft) 06:03:57 INFO - PROCESS | 15281 | RSS: Main: 196829184 06:03:57 INFO - PROCESS | 15281 | 06:04:00 INFO - PROCESS | 15281 | Cycle 1(1): loaded http://localhost:59414/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59414/tests/kraken/driver.html?testName=audio-fft) 06:04:01 INFO - PROCESS | 15281 | RSS: Main: 263639040 06:04:01 INFO - PROCESS | 15281 | 06:04:03 INFO - PROCESS | 15281 | Cycle 1(1): loaded http://localhost:59414/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59414/tests/kraken/driver.html?testName=audio-oscillator) 06:04:03 INFO - PROCESS | 15281 | RSS: Main: 173674496 06:04:03 INFO - PROCESS | 15281 | 06:04:06 INFO - PROCESS | 15281 | Cycle 1(1): loaded http://localhost:59414/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59414/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:04:06 INFO - PROCESS | 15281 | RSS: Main: 178049024 06:04:06 INFO - PROCESS | 15281 | 06:04:09 INFO - PROCESS | 15281 | Cycle 1(1): loaded http://localhost:59414/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59414/tests/kraken/driver.html?testName=imaging-darkroom) 06:04:10 INFO - PROCESS | 15281 | RSS: Main: 214106112 06:04:10 INFO - PROCESS | 15281 | 06:04:14 INFO - PROCESS | 15281 | Cycle 1(1): loaded http://localhost:59414/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59414/tests/kraken/driver.html?testName=imaging-desaturate) 06:04:14 INFO - PROCESS | 15281 | RSS: Main: 212451328 06:04:14 INFO - PROCESS | 15281 | 06:04:17 INFO - PROCESS | 15281 | Cycle 1(1): loaded http://localhost:59414/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59414/tests/kraken/driver.html?testName=json-parse-financial) 06:04:18 INFO - PROCESS | 15281 | RSS: Main: 213610496 06:04:18 INFO - PROCESS | 15281 | 06:04:19 INFO - PROCESS | 15281 | Cycle 1(1): loaded http://localhost:59414/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59414/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:04:20 INFO - PROCESS | 15281 | RSS: Main: 202051584 06:04:20 INFO - PROCESS | 15281 | 06:04:22 INFO - PROCESS | 15281 | Cycle 1(1): loaded http://localhost:59414/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59414/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:04:22 INFO - PROCESS | 15281 | RSS: Main: 205283328 06:04:22 INFO - PROCESS | 15281 | 06:04:25 INFO - PROCESS | 15281 | Cycle 1(1): loaded http://localhost:59414/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59414/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:04:25 INFO - PROCESS | 15281 | RSS: Main: 213790720 06:04:25 INFO - PROCESS | 15281 | 06:04:28 INFO - PROCESS | 15281 | Cycle 1(1): loaded http://localhost:59414/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59414/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:04:29 INFO - PROCESS | 15281 | RSS: Main: 221036544 06:04:29 INFO - PROCESS | 15281 | 06:04:31 INFO - PROCESS | 15281 | Cycle 1(1): loaded http://localhost:59414/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59414/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:04:32 INFO - PROCESS | 15281 | RSS: Main: 217554944 06:04:32 INFO - PROCESS | 15281 | 06:04:34 INFO - PROCESS | 15281 | Cycle 1(1): loaded http://localhost:59414/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59414/tests/kraken/driver.html?testName=ai-astar) 06:04:34 INFO - PROCESS | 15281 | RSS: Main: 262320128 06:04:34 INFO - PROCESS | 15281 | 06:04:34 INFO - PROCESS | 15281 | __start_tp_report 06:04:34 INFO - PROCESS | 15281 | _x_x_mozilla_page_load 06:04:34 INFO - PROCESS | 15281 | _x_x_mozilla_page_load_details 06:04:34 INFO - PROCESS | 15281 | |i|pagename|runs| 06:04:34 INFO - PROCESS | 15281 | |0;ai-astar;113;105;113;110;111;111;109;110;108;112 06:04:34 INFO - PROCESS | 15281 | |1;audio-beat-detection;157;128;158;229;134;154;163;125;181;128 06:04:34 INFO - PROCESS | 15281 | |2;audio-dft;161;163;161;163;163;162;163;164;161;161 06:04:34 INFO - PROCESS | 15281 | |3;audio-fft;75;75;77;152;77;75;76;74;130;74 06:04:34 INFO - PROCESS | 15281 | |4;audio-oscillator;92;91;148;91;91;91;136;91;91;134 06:04:34 INFO - PROCESS | 15281 | |5;imaging-gaussian-blur;117;117;116;117;117;116;116;116;117;117 06:04:34 INFO - PROCESS | 15281 | |6;imaging-darkroom;146;145;145;151;145;146;145;147;146;147 06:04:34 INFO - PROCESS | 15281 | |7;imaging-desaturate;95;95;94;95;95;96;94;95;95;95 06:04:34 INFO - PROCESS | 15281 | |8;json-parse-financial;57;56;57;57;58;57;59;121;55;60 06:04:34 INFO - PROCESS | 15281 | |9;json-stringify-tinderbox;57;58;58;58;59;58;62;60;58;59 06:04:34 INFO - PROCESS | 15281 | |10;stanford-crypto-aes;77;77;79;77;78;79;80;80;84;79 06:04:34 INFO - PROCESS | 15281 | |11;stanford-crypto-ccm;125;122;135;127;121;122;121;130;209;121 06:04:34 INFO - PROCESS | 15281 | |12;stanford-crypto-pbkdf2;176;167;169;172;166;166;168;168;165;168 06:04:34 INFO - PROCESS | 15281 | |13;stanford-crypto-sha256-iterative;66;64;69;64;63;63;63;63;63;63 06:04:34 INFO - PROCESS | 15281 | __end_tp_report 06:04:34 INFO - PROCESS | 15281 | __start_cc_report 06:04:34 INFO - PROCESS | 15281 | _x_x_mozilla_cycle_collect,1850 06:04:34 INFO - PROCESS | 15281 | __end_cc_report 06:04:34 INFO - PROCESS | 15281 | __startTimestamp1462885474489__endTimestamp 06:04:34 INFO - PROCESS | 15281 | 06:04:34 INFO - PROCESS | 15281 | ------- Summary: start ------- 06:04:34 INFO - PROCESS | 15281 | Number of tests: 14 06:04:34 INFO - PROCESS | 15281 | 06:04:34 INFO - PROCESS | 15281 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:2.44 (2.2%) stddev-sans-first:2.37 06:04:34 INFO - PROCESS | 15281 | Values: 113.0 105.0 113.0 110.0 111.0 111.0 109.0 110.0 108.0 112.0 06:04:34 INFO - PROCESS | 15281 | 06:04:34 INFO - PROCESS | 15281 | [#1] audio-beat-detection Cycles:10 Average:155.70 Median:157.50 stddev:31.67 (20.1%) stddev-sans-first:33.58 06:04:34 INFO - PROCESS | 15281 | Values: 157.0 128.0 158.0 229.0 134.0 154.0 163.0 125.0 181.0 128.0 06:04:34 INFO - PROCESS | 15281 | 06:04:34 INFO - PROCESS | 15281 | [#2] audio-dft Cycles:10 Average:162.20 Median:163.00 stddev:1.14 (0.7%) stddev-sans-first:1.12 06:04:34 INFO - PROCESS | 15281 | Values: 161.0 163.0 161.0 163.0 163.0 162.0 163.0 164.0 161.0 161.0 06:04:34 INFO - PROCESS | 15281 | 06:04:34 INFO - PROCESS | 15281 | [#3] audio-fft Cycles:10 Average:88.50 Median:75.00 stddev:28.17 (37.6%) stddev-sans-first:29.45 06:04:34 INFO - PROCESS | 15281 | Values: 75.0 75.0 77.0 152.0 77.0 75.0 76.0 74.0 130.0 74.0 06:04:34 INFO - PROCESS | 15281 | 06:04:34 INFO - PROCESS | 15281 | [#4] audio-oscillator Cycles:10 Average:105.60 Median:91.00 stddev:23.55 (25.9%) stddev-sans-first:24.46 06:04:34 INFO - PROCESS | 15281 | Values: 92.0 91.0 148.0 91.0 91.0 91.0 136.0 91.0 91.0 134.0 06:04:34 INFO - PROCESS | 15281 | 06:04:34 INFO - PROCESS | 15281 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 06:04:34 INFO - PROCESS | 15281 | Values: 117.0 117.0 116.0 117.0 117.0 116.0 116.0 116.0 117.0 117.0 06:04:34 INFO - PROCESS | 15281 | 06:04:34 INFO - PROCESS | 15281 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:1.83 (1.3%) stddev-sans-first:1.94 06:04:34 INFO - PROCESS | 15281 | Values: 146.0 145.0 145.0 151.0 145.0 146.0 145.0 147.0 146.0 147.0 06:04:34 INFO - PROCESS | 15281 | 06:04:34 INFO - PROCESS | 15281 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 06:04:34 INFO - PROCESS | 15281 | Values: 95.0 95.0 94.0 95.0 95.0 96.0 94.0 95.0 95.0 95.0 06:04:34 INFO - PROCESS | 15281 | 06:04:34 INFO - PROCESS | 15281 | [#8] json-parse-financial Cycles:10 Average:63.70 Median:57.00 stddev:20.18 (35.4%) stddev-sans-first:21.26 06:04:34 INFO - PROCESS | 15281 | Values: 57.0 56.0 57.0 57.0 58.0 57.0 59.0 121.0 55.0 60.0 06:04:34 INFO - PROCESS | 15281 | 06:04:34 INFO - PROCESS | 15281 | [#9] json-stringify-tinderbox Cycles:10 Average:58.70 Median:58.50 stddev:1.42 (2.4%) stddev-sans-first:1.36 06:04:34 INFO - PROCESS | 15281 | Values: 57.0 58.0 58.0 58.0 59.0 58.0 62.0 60.0 58.0 59.0 06:04:34 INFO - PROCESS | 15281 | 06:04:34 INFO - PROCESS | 15281 | [#10] stanford-crypto-aes Cycles:10 Average:79.00 Median:79.00 stddev:2.11 (2.7%) stddev-sans-first:2.11 06:04:34 INFO - PROCESS | 15281 | Values: 77.0 77.0 79.0 77.0 78.0 79.0 80.0 80.0 84.0 79.0 06:04:34 INFO - PROCESS | 15281 | 06:04:34 INFO - PROCESS | 15281 | [#11] stanford-crypto-ccm Cycles:10 Average:133.30 Median:126.00 stddev:27.00 (21.4%) stddev-sans-first:28.47 06:04:34 INFO - PROCESS | 15281 | Values: 125.0 122.0 135.0 127.0 121.0 122.0 121.0 130.0 209.0 121.0 06:04:34 INFO - PROCESS | 15281 | 06:04:34 INFO - PROCESS | 15281 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.50 Median:168.00 stddev:3.27 (1.9%) stddev-sans-first:2.06 06:04:34 INFO - PROCESS | 15281 | Values: 176.0 167.0 169.0 172.0 166.0 166.0 168.0 168.0 165.0 168.0 06:04:34 INFO - PROCESS | 15281 | 06:04:34 INFO - PROCESS | 15281 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.10 Median:63.50 stddev:1.97 (3.1%) stddev-sans-first:1.96 06:04:34 INFO - PROCESS | 15281 | Values: 66.0 64.0 69.0 64.0 63.0 63.0 63.0 63.0 63.0 63.0 06:04:34 INFO - PROCESS | 15281 | -------- Summary: end -------- 06:04:34 INFO - PROCESS | 15281 | 06:04:35 INFO - TEST-INFO | 15281: exit 0 06:04:35 INFO - TEST-OK | kraken | took 65208ms 06:04:35 INFO - SUITE-END | took 1180s 06:04:36 INFO - Completed test suite (00:19:40) 06:04:36 INFO - javascript benchmark 06:04:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3137.5764271823296, 3140.7173354398105, 3159.3049529103596, 3182.347618738159, 3200.1679563313533, 5272.604554658402, 5296.390915044771, 5365.7585408656605, 5369.677819330833, 5398.514133727964, 5325.121354976424, 5330.0, 5345.679259244448, 5401.108817045193, 5443.074677304858, 4777.952220477794, 4873.853784386474, 4882.145624515713, 4923.926141107886, 5077.111505486543, 4992.925106123393, 5019.121653710605, 5039.0425819094435, 5061.746912654371, 5063.392392912837, 4771.952280477186, 4815.7110573365535, 4853.684510506841, 4857.271409288635, 4886.828960986366, 4850.733209673466, 4858.368412106439, 4923.286123512106, 4927.285543596195, 4967.577755890754, 4801.327814106028, 4903.092927808331, 4905.681130726492, 4928.457869634337, 4958.553730164266, 5211.270422140903, 5263.236830659571, 5285.445028272053, 5374.785008599691, 5379.5427388671615, 5756.280464941882, 5774.769009239625, 5805.10020946754, 5825.475707186373, 5826.9708651456895, 5634.802781902655, 5720.370759216483, 5938.079597662369, 5965.701714914237, 5973.283206015262, 5436.619436639437, 5550.4449555044175, 5559.0, 5561.4716601923155, 5563.109902415594, 6023.939760602426, 6067.605605635619, 6075.210222671025, 6082.57421980466, 6085.4523092921845, 5603.075492543766, 5673.971630141823, 5700.885982280414, 5778.479936805707, 5830.5627077968475, 5885.6174348668055, 5887.676177810176, 5889.1755154278435, 5894.587378883437, 5938.584299099021, 5819.941800582024, 5861.9706901465215, 5865.120231965239, 5877.706114694333, 5878.706064696748, 5573.637713548606, 5671.971640141773, 5744.540436765049, 5747.597668163188, 5880.26496687914, 4242.236397448427, 4245.702800803976, 4247.256730072225, 4249.2563801334645, 4277.486701595828, 3817.866374676873, 3822.445745366962, 3843.0, 3865.96134038656, 3872.8644497442456, 5323.467653234646, 5442.836714898559, 5496.093144631171, 5527.50252477279, 5559.138333558305, 5904.852378690482, 5913.349531551526, 5922.911156332659, 5924.911126333109, 5931.614445061057, 5290.391604965478, 5537.640053396597, 5553.916691249635, 5561.555075593943, 5564.304461942257, 4843.927341089887, 4873.829415970424, 4889.657723959289, 4930.975345123252, 4945.109880221595, 6086.878262434727, 6089.786857459968, 6091.329953705089, 6092.786752463731, 6101.755929762849, 5666.914996275142, 5683.119116536944, 5906.940930590725, 5918.141869428822, 5930.614510056833, 5906.557008224487, 5964.31410387811, 5969.074793406855, 5975.970120149372, 6025.789097381746, 5625.831225063254, 5670.064439367623, 5681.261436013292, 5682.545396368363, 5688.260526131577, 5694.088945768657, 5705.714714264187, 5781.103928891029, 5786.189933409242, 5801.129830525455, 5700.429957004267, 5709.172170035238, 5716.199732037435, 5716.256886604715, 5751.194832723506, 5636.267285252891, 5655.4910058094965, 5689.886202276014, 5691.089425692035, 5695.088785794253, 5409.702466364388, 5488.396276409512, 5576.33084029919, 5594.524465420485, 5597.832065038056, 5776.277965254343, 5785.247917770663, 5833.82498525045, 5836.970815145897, 5838.474537291664, 5601.6358936668985, 5652.717364131695, 5660.660360378391, 5661.264035675335, 5699.51554117888], "value": 5342.143793126273, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [606.2119244981526, 625.1060982794602, 643.478782186429, 661.8444665503607, 662.000379427065, 43785.0, 45221.32168017482, 45321.374290056796, 45337.54662453379, 48383.758081209635, 45098.0, 45579.54420455795, 45595.544044559545, 45664.77167614165, 45667.08665826682, 9029.458232506055, 9141.314401419886, 9176.770580735501, 9178.908210917905, 9191.724248272563, 8967.237784788302, 9056.728298151065, 9068.682596109138, 9073.63705451781, 9076.682316118937, 9106.635734570642, 9151.67969121081, 9179.0, 9189.035151309117, 9204.953975230115, 9118.772030699252, 9137.497437640926, 9142.72571822843, 9166.450012999241, 9167.0, 8933.46399216049, 9022.684206052756, 9023.729288121302, 9023.909760902372, 9024.954875225581, 42463.15073698509, 42709.57290427118, 42931.57068429307, 42966.78516607428, 43114.0, 3552.6447355264268, 3682.3371793077235, 3758.624137586247, 3861.710371722104, 4284.507281662618, 31865.84067079673, 32926.0, 33062.33875322504, 33078.834605827054, 33237.50143747846, 4311.568843115695, 4320.891977700551, 4325.048489332374, 4370.147821174872, 4418.779061046935, 311129.0, 312111.0, 313653.0, 314135.0, 314260.0, 62329.0, 62732.686336568026, 62847.0, 62870.37129628645, 62936.37063629305, 38922.41616375757, 40026.59973400229, 40048.59951400507, 40122.79938600347, 40160.59839401627, 17183.0, 17284.0, 17389.130543472776, 17396.565085872702, 17400.825991740174, 13010.414531345923, 13186.802197967038, 13190.076694631476, 13197.406116724771, 13205.0, 20039.094331321878, 20148.798512014986, 20193.495162621053, 20293.492662683257, 20356.18575257003, 6904.0, 6915.273896240923, 7034.859302814018, 7157.642117894085, 7286.635668216674, 1027.814993301213, 1106.3085571517802, 1123.230587047875, 1140.5551834784442, 1143.0284258380311, 31756.206094847814, 31956.360872782414, 31996.20009499781, 32486.187845304055, 32786.836065819516, 1075.8977897099762, 1169.3977601535216, 1179.2511755035443, 1188.7979043562616, 1223.1621339382552, 17596.29614815393, 17665.55836104082, 18243.5681952272, 18380.724289135673, 18849.24603015864, 479051.0, 481957.0, 482452.0, 482996.0, 483800.0, 57447.0, 58856.0, 58876.11685824716, 58895.41104588899, 58997.0, 1282.1089342906591, 1390.2075816784336, 1395.4976208564908, 1435.655442693746, 1440.1862947434875, 31126.0, 32733.34533309273, 32937.0, 32987.0, 33627.32745345031, 49911.75044124756, 50840.0, 50927.49072509228, 50950.49049509457, 50963.0, 363762.0, 373898.0, 374172.0, 375128.7461376163, 375697.0, 25740.871295643403, 27714.584281235395, 28488.715112848608, 28693.713062869938, 30745.846270768503, 47002.29496557486, 47707.28439073486, 48055.279170811766, 48314.275285871445, 48983.51016489932, 39450.0, 39837.80081099576, 40375.59624403718, 40546.0, 40934.1813163741, 39579.208415830944, 39883.80058099691, 39942.20115597614, 40445.59554404418, 40860.0, 39717.404238937015, 40731.796341018104, 40764.1847163061, 40776.3883541753, 41025.79487102546, 34620.65379346275, 35667.286654267285, 35850.641493585776, 36495.45256821203, 36720.898373048854, 27663.0, 27668.8616556924, 27837.582436263066, 27900.441991160467, 27964.80527920828], "value": 20090.090713527727, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.30509041361177, 400.8857475619445, 401.24966312994695, 411.3131071111242, 415.22560424807745, 17697.380591679295, 18162.818371816276, 19105.52236194096, 19139.71290430643, 19232.0, 17508.387206447776, 18173.90913045436, 18320.63358732828, 18388.540286492844, 18490.0, 5562.276904002474, 5595.804146854861, 5792.623479473821, 5798.594098413113, 5803.158542011406, 5249.921251181236, 5308.283381743454, 5315.335583052119, 5328.973355133238, 5339.813106541272, 5247.842564723064, 5277.683338999653, 5279.5512381447625, 5696.829095127132, 5708.800191993281, 5646.0, 5666.886662266732, 5682.857928551778, 5700.144978253254, 5703.828885133432, 4916.385451818523, 5080.771365288534, 5248.396434410053, 5260.684358938438, 5294.285271488338, 13296.534621288209, 13764.65588360289, 13861.514846980308, 13904.58286251414, 13925.025248232629, 2112.4402033461147, 2210.149092599345, 2231.3975226688704, 2282.874441905711, 2326.441654003044, 9717.757056073584, 9792.510374481319, 10148.188144948386, 10195.388276703421, 10238.7440313992, 1813.9274429022823, 1913.425972208346, 1927.7902292682666, 1938.370029740326, 1943.4364034429998, 60919.69540152271, 76491.23508764897, 78681.60659196724, 82585.39316854638, 86816.0, 10363.222758293008, 10401.947990260152, 10679.57281708723, 10966.093985093798, 10979.39613321275, 13556.254406007763, 15771.526854194393, 15775.763363549557, 15778.763318550002, 15806.972546784422, 7462.70149194037, 7774.689012439552, 7967.681292748225, 8043.758687239275, 8143.389245806588, 7782.0, 7909.3277071449575, 7967.681292748341, 8118.3099436548555, 8133.146019667968, 4756.904861902812, 4825.782839772219, 4851.466338702739, 4853.563179313879, 4903.436104847917, 1870.7755069391487, 1873.3536929759211, 1885.264746748769, 1934.4970307720093, 1963.2834015584208, 881.5195718333524, 968.3415277611151, 1015.5582321690089, 1027.0551092994463, 1060.9469526523797, 18026.459206223833, 18261.360852370104, 18424.35514757004, 18520.16659250337, 18764.437066888015, 988.7280997725683, 1019.8980101989741, 1025.3335332034237, 1064.1114669251108, 1080.2762149359949, 9060.275177985744, 10393.37639741618, 10452.320599161183, 10486.0, 10504.579816807394, 482422.0, 495710.0, 496258.0, 498652.0, 502296.0, 50615.49384506108, 60294.39705602975, 66838.0, 76666.0, 89562.55218723995, 1023.6468418395641, 1048.2295512798087, 1061.888501707325, 1071.8552995345528, 1076.9084627806567, 16336.264868080727, 16629.50111496657, 16667.16664166811, 16812.24344904507, 17028.14859257057, 39213.80393098016, 39505.407418889314, 41097.38353924634, 41722.0, 42035.7898210507, 53757.73121134526, 56499.43500565106, 56928.0, 57140.42859571517, 57568.424315757984, 8034.558099304594, 8592.3555733319, 8733.30133589324, 8744.0, 8832.602532885907, 12011.399430028638, 12061.698457538632, 12546.435410406371, 12715.93642031784, 12718.300493472947, 11169.0, 11242.325460472397, 11285.605003824827, 11360.54557817678, 11391.829122563335, 8980.86528702057, 10644.148468122377, 10783.784324313312, 11194.384308863091, 11382.886171138183, 11125.109991200847, 11191.384473854016, 11320.150988676047, 11500.884991150317, 11750.236234645063, 8499.065102838806, 8528.658853645784, 8635.093315202064, 8643.654253829776, 8795.032546420016, 8588.355873309401, 10437.32157409766, 10998.06516446111, 11098.334099954029, 11665.308530263233], "value": 8799.33206997909, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1343.67080065384, 1476.1512130524948, 1539.6150962259435, 1643.7698722178898, 1770.9734353984684, 7970.601469926502, 8250.174982501754, 8297.958510207449, 8492.617832197551, 8505.532195729233, 8293.91706082939, 8453.281471074966, 8473.78815529612, 8476.745697629065, 8478.957605211965, 2037.8573499855015, 2087.5824835032977, 2091.435312465633, 2298.5173113646156, 2319.3621754017613, 2288.9084436622516, 2376.2989917974237, 2379.9048038078454, 2391.485830546432, 2398.784109430151, 2321.872297023663, 2361.775631315022, 2372.323887692008, 2387.2241521505493, 2390.270967354956, 2023.6660950943076, 2099.0554250587297, 2324.4537533679572, 2355.3051849704293, 2361.409647588103, 2262.7058482397347, 2319.4665226997886, 2330.0330362899545, 2335.1826860598826, 2342.355852140658, 8287.792805179859, 8362.749117526484, 8465.0, 8465.915340846574, 8488.575571221414, 5108.540231379194, 5222.503862133091, 5228.137357336035, 5254.553362964152, 5262.447443018466, 3331.4003479373705, 3388.8983330500123, 3498.912527186815, 3511.262634846685, 3534.7525673202886, 1119.5297974850582, 1124.2579897267765, 1149.109440183864, 1169.3685409878656, 1173.8297946797752, 11989.280643161352, 11998.820017699742, 12006.519739210422, 12030.218035827644, 12058.276503409823, 4576.977115114403, 4579.885502862388, 4657.184992626277, 4659.2312268476, 4710.788014539354, 9896.55465504054, 9954.701358959099, 9972.850407243897, 9975.800483990279, 9994.600215991424, 5227.032998895141, 5243.737813109329, 5273.525382715574, 5290.0, 5294.100002999422, 4379.496357918816, 4641.118187544355, 4737.6683632146105, 4797.328374027639, 4900.558949694545, 3904.921901561953, 3953.6755187012673, 4007.8196481158416, 4026.6376026157786, 4033.032072302685, 1255.8869701726887, 1257.5158563952943, 1274.5156840400773, 1284.3064745037761, 1289.1491615533703, 996.3324572536418, 998.1515711645188, 1000.3797645459862, 1001.1940387987739, 1011.7420057885192, 5705.372409035002, 5722.456366645162, 5837.845376795073, 5869.0, 6016.308124565643, 446.8659402179333, 449.05922093215315, 450.7633492416442, 1035.77213013137, 1050.8003479339054, 4139.172165566899, 4174.853880114181, 4196.51740049892, 4203.684723645739, 4237.809298581571, 10594.417307048187, 10958.28771129874, 10997.395143267197, 11053.447327633587, 11141.275817071864, 10765.439011343311, 10931.672049838518, 10967.83548246777, 10990.725231869268, 11014.229003969805, 7815.101263354787, 7869.527828330319, 8007.559584222924, 8124.512529248264, 8152.2255385739445, 5331.333583302087, 5556.38879723222, 5561.694106824163, 5611.831645050655, 5718.1708652246025, 9844.901550984685, 9969.102780749767, 10137.442440665835, 10171.13545348624, 10332.17342612574, 10317.071463568314, 10318.329308594917, 10355.0, 10359.896401036194, 10464.162866970471, 7083.327083927019, 7394.0, 7573.810654733676, 7780.144184139627, 7968.402369822171, 8327.54198519063, 8330.291925186184, 8395.70615028471, 8406.28546573548, 8429.325653947792, 7398.297161769623, 7612.961935190288, 7629.46593738433, 7685.961570192113, 7722.189170137055, 7397.4082073435075, 7478.5138965967035, 7492.400607951242, 7607.543547387175, 7635.847283054197, 6915.89626155598, 6957.4086202671315, 6962.582245065312, 6989.30106989297, 6994.33553812387, 4725.40932383452, 4883.536064073907, 4896.338994235733, 4926.211806111005, 4950.975245123751, 4950.183219768698, 5004.97398033395, 5009.398872135367, 5122.769475373691, 5137.383513978347], "value": 4548.209654888249, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.6839701099774, 343.64432812039536, 346.5460247076332, 348.4807636621435, 349.04536093783514, 5150.587952963763, 5236.7905283788605, 5307.442718514559, 5399.568034557241, 5403.7027963462, 5281.128613778722, 5313.282706834586, 5315.627906046579, 5320.898245193146, 5333.679979201241, 4141.088960428701, 4212.368144778277, 4225.366195070748, 4227.85202517912, 4235.491740991085, 3991.900202494932, 4056.655184309337, 4185.518665353477, 4204.516480604724, 4237.322028475444, 4129.256733787917, 4148.0874207674415, 4148.834046638146, 4149.502059752834, 4178.456800615931, 4136.710430269883, 4140.8136633851545, 4141.233871733739, 4150.896227594304, 4150.958490415118, 3465.4455287154187, 3682.760620559655, 3697.9445308320396, 3701.5188025556504, 3723.2181241939224, 5136.74316284188, 5145.202493613496, 5145.3568303962, 5170.767315470813, 5208.9739551302, 4761.0, 4774.777025507803, 4777.713337199744, 4777.761111944424, 4779.402574678165, 5415.729213539307, 5479.0959491683825, 5579.776808927638, 5595.776168953237, 5618.63478873876, 3985.7608543487486, 4013.177298653769, 4017.4332010515923, 4039.5758445363404, 4040.1919616076902, 5722.856928576777, 5779.855503612402, 5790.594658373873, 5791.509650850133, 5849.415058494116, 3966.147278335172, 4062.192324415607, 4071.877843664695, 4079.4288799568085, 4080.1431699342875, 4155.127423241092, 4175.31107367287, 4182.0, 4191.805335479435, 4203.684723645739, 4743.762811859393, 4752.714837109785, 4753.168195565762, 4756.691909724854, 4759.595434388116, 5352.518273355417, 5600.243967064394, 5622.0, 5629.915551266734, 5643.971780141073, 1369.869862363074, 1386.3484162443635, 1389.3817251323267, 1398.7971744097254, 1415.2004117673482, 942.0014784328633, 966.3089593211879, 969.413504829582, 969.7963427680126, 975.7902051059057, 5113.41195762492, 5241.0828105081455, 5274.756025044647, 5277.8416647500635, 5329.9467005330225, 5432.837014889559, 5460.235567020621, 5462.317210348707, 5524.640898341675, 5539.41836107211, 5040.420351659606, 5109.514596113363, 5194.766235519411, 5250.501202385767, 5293.497117773805, 2931.6188895443456, 2956.713829484181, 2959.8604537253314, 2962.333474968115, 2985.7611391088662, 5762.0985074925175, 5770.019096753562, 5792.536597072224, 5849.707514624251, 5858.0, 5424.972875135599, 5629.0, 5631.662100273997, 5640.774369025193, 5641.153826925994, 5560.165975103686, 5724.856878577985, 5727.713614319267, 5777.740001699934, 5801.361850196475, 5399.379071406838, 5552.0, 5599.972000139973, 5616.466435688603, 5663.830085097289, 5594.41258667834, 5613.298337707786, 5637.830865074055, 5651.547876169979, 5679.687617180929, 5898.428717743783, 5935.5548333875995, 5940.6435613863305, 5954.3152537458745, 5983.311919129356, 3961.8613348532663, 4006.198760247904, 4229.302165142717, 4232.830686772618, 4236.957630423656, 5678.858028549319, 5684.015891656748, 5703.5722320826935, 5707.600467967202, 5720.971395142998, 5564.666120032811, 5572.888542229051, 5577.860553486195, 5614.2701448811395, 5635.6618602883955, 5328.946710532845, 5559.9444005561045, 5580.888382232251, 5590.357108932525, 5622.297212848394, 5478.671279723229, 5487.176923461513, 5520.861978450571, 5556.972215138899, 5589.77640894376, 5329.413764485826, 5607.439256074523, 5609.467100625434, 5676.574256930664, 5708.229389032427, 5438.646487978269, 5460.535854452416, 5486.286782718381, 5505.807296744595, 5528.778848846001], "value": 4239.271359737181, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [757.7461550380622, 823.4935514658484, 859.6002858670719, 866.6706651472443, 866.8049688820013, 13613.65965850853, 14671.706565868677, 14679.045862018975, 14696.0, 14718.779218311734, 13138.474461021571, 13138.93430532846, 13159.078864479467, 13178.472861085545, 13181.0, 696.5890124826351, 821.4455242711161, 825.0594322472386, 840.9075001749802, 842.7640260726976, 832.5046597274642, 836.9665213391457, 839.9286060684849, 840.9873851892227, 841.8063845315551, 876.2551830943711, 878.5168157513374, 878.6661068793882, 878.8813510176141, 879.1033146190881, 693.4937495628194, 850.3834719828137, 863.2230992107154, 865.2861389353745, 868.1535502884637, 631.5610650597837, 632.2855173653742, 633.3887798274687, 633.933436989114, 634.3719717479707, 13392.464301427932, 13429.731405371935, 13433.932830335785, 13439.596812095653, 13448.596542103753, 13711.725765484734, 13838.93080534601, 13892.374843132084, 13955.511557095453, 13977.0, 11926.642200733992, 11946.940265298617, 12062.939685301604, 12145.210561313575, 12441.75116497665, 4515.345274935149, 4523.32150177476, 4547.375118680114, 4560.24433088471, 4659.767011649438, 54258.18612720812, 54454.72772636151, 56007.0, 56253.71873140649, 56569.15146272768, 10903.0, 10920.563177472972, 10922.402333286995, 10939.179561532917, 11051.447427628747, 18821.15304811287, 18835.340763073225, 18837.434876953714, 18841.717374239397, 18847.24611015544, 7866.331361834194, 8071.636776345079, 8227.958860205661, 8319.084900660922, 8399.664013439395, 4582.793774280099, 4665.4168228971375, 4705.317728929286, 4761.571458568746, 4825.855224343275, 3212.7751057425758, 3258.9837050815067, 3263.543103965447, 3268.5587445695, 3294.769366144395, 669.1167658690579, 672.0725398949419, 687.1376422589618, 690.1614538335946, 713.400743375567, 659.235287067, 682.607500687107, 804.2600807257337, 806.3549160671439, 822.7901885019281, 10024.398536087858, 10248.48757562119, 10299.227557933185, 10373.636922707668, 10505.159587233004, 760.4676278685475, 779.9571023593757, 782.7456076774957, 784.3450718649877, 815.2458975447687, 4485.551444855489, 4879.463259041502, 4907.607391408679, 4961.255811628284, 4992.2511623256805, 67250.32749672538, 67297.0, 68992.3100768996, 69217.3078269221, 70473.0, 59359.70320148372, 59830.0, 60909.0, 62488.0, 63482.36517634857, 55006.72496637491, 55252.171217430965, 55439.0, 55689.164662529285, 56120.0, 8871.201591856763, 8923.375363724737, 8932.419392739452, 8981.326400519856, 9039.548022598976, 35064.29871402507, 35103.0, 35126.473102902964, 35411.99999999897, 35760.10599735028, 43951.34072988844, 46227.0, 48749.0, 48759.512404875495, 49955.75022124866, 11079.169062320198, 11290.0, 11292.604758833402, 11724.179307448398, 11909.464074116513, 12167.878321216675, 12392.690182745142, 12405.75188496243, 12429.37853107323, 12928.095033347952, 11880.287182769061, 11989.40052997364, 11990.160688751703, 12093.0, 12211.87788122143, 11577.6526704199, 11914.940425297818, 11943.10426718017, 12239.082068844695, 12388.62834114978, 11551.364674942623, 11600.18798684084, 11763.235389699643, 11812.40937953116, 11888.643340699793, 9678.509316770187, 9862.852057219005, 9927.205823534245, 9956.950215248877, 10151.137153342048, 9926.900730992598, 10069.496525173565, 10086.344387614781, 10142.645007424704, 10155.187584993331], "value": 6857.607932955545, "unit": "score"}], "name": "dromaeo_css", "value": 7069.94570993751, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 105.0, 113.0, 110.0, 111.0, 111.0, 109.0, 110.0, 108.0, 112.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 128.0, 158.0, 229.0, 134.0, 154.0, 163.0, 125.0, 181.0, 128.0], "value": 155.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 161.0, 163.0, 163.0, 162.0, 163.0, 164.0, 161.0, 161.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 152.0, 77.0, 75.0, 76.0, 74.0, 130.0, 74.0], "value": 88.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 148.0, 91.0, 91.0, 91.0, 136.0, 91.0, 91.0, 134.0], "value": 105.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 116.0, 116.0, 117.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 151.0, 145.0, 146.0, 145.0, 147.0, 146.0, 147.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 96.0, 94.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 57.0, 57.0, 58.0, 57.0, 59.0, 121.0, 55.0, 60.0], "value": 63.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 58.0, 58.0, 59.0, 58.0, 62.0, 60.0, 58.0, 59.0], "value": 58.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 79.0, 77.0, 78.0, 79.0, 80.0, 80.0, 84.0, 79.0], "value": 79.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 122.0, 135.0, 127.0, 121.0, 122.0, 121.0, 130.0, 209.0, 121.0], "value": 133.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 167.0, 169.0, 172.0, 166.0, 166.0, 168.0, 168.0, 165.0, 168.0], "value": 168.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 69.0, 64.0, 63.0, 63.0, 63.0, 63.0, 63.0, 63.0], "value": 64.1, "unit": "score"}], "name": "kraken", "value": 1547.2999999999997, "alertThreshold": 2.0}]} 06:04:36 INFO - Return code: 0 06:04:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:04:36 ERROR - # TBPL SUCCESS # 06:04:36 INFO - Running post-action listener: _resource_record_post_action 06:04:36 INFO - ##### 06:04:36 INFO - ##### Finished run-tests step (success) 06:04:36 INFO - ##### 06:04:36 INFO - Running post-run listener: _resource_record_post_run 06:04:37 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 541708288; Read time: 12; Write time: 1362892 06:04:37 INFO - install - Wall time: 17s; CPU: 17.0%; Read bytes: 0; Write bytes: 245043200; Read time: 0; Write time: 676372 06:04:37 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 296611840; Read time: 12; Write time: 686500 06:04:37 INFO - Running post-run listener: _upload_blobber_files 06:04:37 INFO - Blob upload gear active. 06:04:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:04:37 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:04:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:04:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:04:37 INFO - (blobuploader) - INFO - Open directory for files ... 06:04:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:04:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:04:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:04:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:04:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:04:38 INFO - (blobuploader) - INFO - Done attempting. 06:04:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:04:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:04:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:04:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:04:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:04:39 INFO - (blobuploader) - INFO - Done attempting. 06:04:39 INFO - (blobuploader) - INFO - Iteration through files over. 06:04:39 INFO - Return code: 0 06:04:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:04:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:04:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/baf2cbe614a2429b649ce972fb92e5dc3a5017f5e677b2c908d8a800538040e049c8d1fca81cee6afe2d0f595935deb696e47251a25df1517ac62ac5cd69a177", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/255b708258db8453c3aca3c2af18d1d514a72308d050713a20153db1dd535c564a4eb53c025b143ab1c1a2a81c4075c3e2f99cde45ff293aa7faaba6532ab0be"} 06:04:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:04:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:04:39 INFO - Contents: 06:04:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/baf2cbe614a2429b649ce972fb92e5dc3a5017f5e677b2c908d8a800538040e049c8d1fca81cee6afe2d0f595935deb696e47251a25df1517ac62ac5cd69a177", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/255b708258db8453c3aca3c2af18d1d514a72308d050713a20153db1dd535c564a4eb53c025b143ab1c1a2a81c4075c3e2f99cde45ff293aa7faaba6532ab0be"} 06:04:39 INFO - Running post-run listener: copy_logs_to_upload_dir 06:04:39 INFO - Copying logs to upload dir... 06:04:39 INFO - mkdir: /builds/slave/test/build/upload/logs 06:04:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.570473 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-05-10 06:04:39.237371) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 06:04:39.240960) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1462884241.694061-1217471790 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/baf2cbe614a2429b649ce972fb92e5dc3a5017f5e677b2c908d8a800538040e049c8d1fca81cee6afe2d0f595935deb696e47251a25df1517ac62ac5cd69a177", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/255b708258db8453c3aca3c2af18d1d514a72308d050713a20153db1dd535c564a4eb53c025b143ab1c1a2a81c4075c3e2f99cde45ff293aa7faaba6532ab0be"} build_url:https://queue.taskcluster.net/v1/task/IaJYfo7WRPOaXE0JMlX2Eg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011211 build_url: 'https://queue.taskcluster.net/v1/task/IaJYfo7WRPOaXE0JMlX2Eg/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/baf2cbe614a2429b649ce972fb92e5dc3a5017f5e677b2c908d8a800538040e049c8d1fca81cee6afe2d0f595935deb696e47251a25df1517ac62ac5cd69a177", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/255b708258db8453c3aca3c2af18d1d514a72308d050713a20153db1dd535c564a4eb53c025b143ab1c1a2a81c4075c3e2f99cde45ff293aa7faaba6532ab0be"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 06:04:39.265740) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 06:04:39.266081) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1462884241.694061-1217471790 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004417 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 06:04:39.351223) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 06:04:39.351661) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 06:04:39.351997) ========= ========= Total master_lag: 0.18 =========