builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-012 starttime: 1462463317.92 results: success (0) buildid: 20160505070954 builduid: 752863efe50d46f79b7decd5e7480d1a revision: 29662e28a9c93ac67ee0b8ddfb65a9f29bbf73f5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-05 08:48:37.917798) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-05 08:48:37.918189) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-05 08:48:37.918457) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-05 08:48:37.936274) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 08:48:37.936657) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1462461527.641334-183314310 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-05 08:48:38-- 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% 224M=0s 2016-05-05 08:48:38 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.103127 ========= master_lag: 0.30 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 08:48:38.343668) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 08:48:38.344035) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1462461527.641334-183314310 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018077 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 08:48:38.438206) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-05 08:48:38.438661) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 29662e28a9c93ac67ee0b8ddfb65a9f29bbf73f5 --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 29662e28a9c93ac67ee0b8ddfb65a9f29bbf73f5 --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=2c5dd2b0a310ecf02fd87158000001b4-1462461527.641334-183314310 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-05 08:48:38,633 truncating revision to first 12 chars 2016-05-05 08:48:38,633 Setting DEBUG logging. 2016-05-05 08:48:38,633 attempt 1/10 2016-05-05 08:48:38,633 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/29662e28a9c9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-05 08:48:39,498 unpacking tar archive at: mozilla-central-29662e28a9c9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.147860 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-05 08:48:39.606369) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-05 08:48:39.606688) ========= script_repo_revision: 29662e28a9c93ac67ee0b8ddfb65a9f29bbf73f5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-05 08:48:39.607115) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-05 08:48:39.607378) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-05 08:48:39.618013) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-05-05 08:48:39.618297) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1462461527.641334-183314310 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:48:39 INFO - MultiFileLogger online at 20160505 08:48:39 in /builds/slave/test 08:48:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 08:48:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:48:39 INFO - {'append_to_log': False, 08:48:39 INFO - 'base_work_dir': '/builds/slave/test', 08:48:39 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:48:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:48:39 INFO - 'branch': 'Firefox-Non-PGO', 08:48:39 INFO - 'buildbot_json_path': 'buildprops.json', 08:48:39 INFO - 'config_files': ('talos/linux_config.py',), 08:48:39 INFO - 'default_actions': ('clobber', 08:48:39 INFO - 'read-buildbot-config', 08:48:39 INFO - 'download-and-extract', 08:48:39 INFO - 'populate-webroot', 08:48:39 INFO - 'create-virtualenv', 08:48:39 INFO - 'install', 08:48:39 INFO - 'run-tests'), 08:48:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:48:39 INFO - 'download_minidump_stackwalk': True, 08:48:39 INFO - 'download_symbols': 'ondemand', 08:48:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:48:39 INFO - 'tooltool.py': '/tools/tooltool.py', 08:48:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:48:39 INFO - '/tools/misc-python/virtualenv.py')}, 08:48:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:48:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:48:39 INFO - 'installer_path': 'installer.exe', 08:48:39 INFO - 'log_level': 'info', 08:48:39 INFO - 'log_name': 'talos', 08:48:39 INFO - 'log_to_console': True, 08:48:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:48:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:48:39 INFO - 'opt_config_files': (), 08:48:39 INFO - 'pip_index': False, 08:48:39 INFO - 'sps_profile': False, 08:48:39 INFO - 'sps_profile_interval': 0, 08:48:39 INFO - 'suite': 'dromaeojs', 08:48:39 INFO - 'system_bits': '32', 08:48:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:48:39 INFO - 'title': 'talos-linux64-ix-012', 08:48:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:48:39 INFO - 'use_talos_json': True, 08:48:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:48:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:48:39 INFO - 'work_dir': 'build'} 08:48:39 INFO - ##### 08:48:39 INFO - ##### Running clobber step. 08:48:39 INFO - ##### 08:48:39 INFO - Running pre-action listener: _resource_record_pre_action 08:48:39 INFO - Running main action method: clobber 08:48:39 INFO - rmtree: /builds/slave/test/build 08:48:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:48:40 INFO - Running post-action listener: _resource_record_post_action 08:48:40 INFO - ##### 08:48:40 INFO - ##### Running read-buildbot-config step. 08:48:40 INFO - ##### 08:48:40 INFO - Running pre-action listener: _resource_record_pre_action 08:48:40 INFO - Running main action method: read_buildbot_config 08:48:40 INFO - Using buildbot properties: 08:48:40 INFO - { 08:48:40 INFO - "project": "", 08:48:40 INFO - "product": "firefox", 08:48:40 INFO - "script_repo_revision": "production", 08:48:40 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 08:48:40 INFO - "repository": "", 08:48:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 08:48:40 INFO - "buildid": "20160505070954", 08:48:40 INFO - "pgo_build": "False", 08:48:40 INFO - "basedir": "/builds/slave/test", 08:48:40 INFO - "buildnumber": 564, 08:48:40 INFO - "slavename": "talos-linux64-ix-012", 08:48:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:48:40 INFO - "platform": "ubuntu64_hw", 08:48:40 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 08:48:40 INFO - "branch": "mozilla-central", 08:48:40 INFO - "repo_path": "mozilla-central", 08:48:40 INFO - "revision": "29662e28a9c93ac67ee0b8ddfb65a9f29bbf73f5", 08:48:40 INFO - "stage_platform": "linux64", 08:48:40 INFO - "builduid": "752863efe50d46f79b7decd5e7480d1a", 08:48:40 INFO - "slavebuilddir": "test" 08:48:40 INFO - } 08:48:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/NdBx6tzkT4OwufcQJGduGA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 08:48:40 INFO - Running post-action listener: _resource_record_post_action 08:48:40 INFO - ##### 08:48:40 INFO - ##### Running download-and-extract step. 08:48:40 INFO - ##### 08:48:40 INFO - Running pre-action listener: _resource_record_pre_action 08:48:40 INFO - Running main action method: download_and_extract 08:48:40 INFO - mkdir: /builds/slave/test/build/tests 08:48:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:40 INFO - https://queue.taskcluster.net/v1/task/NdBx6tzkT4OwufcQJGduGA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:48:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NdBx6tzkT4OwufcQJGduGA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:48:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NdBx6tzkT4OwufcQJGduGA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:48:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NdBx6tzkT4OwufcQJGduGA/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 08:48:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NdBx6tzkT4OwufcQJGduGA/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 08:48:43 INFO - Downloaded 1361 bytes. 08:48:43 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:48:43 INFO - Using the following test package requirements: 08:48:43 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:48:43 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:48:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:48:43 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:48:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:48:43 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:48:43 INFO - u'jsshell-linux-x86_64.zip'], 08:48:43 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:48:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:48:43 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:48:43 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:48:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:48:43 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:48:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:48:43 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:48:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:48:43 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:48:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:48:43 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:48:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:43 INFO - https://queue.taskcluster.net/v1/task/NdBx6tzkT4OwufcQJGduGA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:48:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NdBx6tzkT4OwufcQJGduGA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:48:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NdBx6tzkT4OwufcQJGduGA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:48:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NdBx6tzkT4OwufcQJGduGA/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 08:48:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NdBx6tzkT4OwufcQJGduGA/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 08:48:44 INFO - Downloaded 22307095 bytes. 08:48:44 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'] 08:48:44 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 08:48:45 INFO - Return code: 0 08:48:45 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 08:48:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:45 INFO - https://queue.taskcluster.net/v1/task/NdBx6tzkT4OwufcQJGduGA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:48:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NdBx6tzkT4OwufcQJGduGA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:48:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NdBx6tzkT4OwufcQJGduGA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:48:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NdBx6tzkT4OwufcQJGduGA/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 08:48:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NdBx6tzkT4OwufcQJGduGA/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 08:48:46 INFO - Downloaded 22307095 bytes. 08:48:46 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'] 08:48:46 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 08:48:48 INFO - Return code: 0 08:48:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:48 INFO - https://queue.taskcluster.net/v1/task/NdBx6tzkT4OwufcQJGduGA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:48:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NdBx6tzkT4OwufcQJGduGA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:48:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NdBx6tzkT4OwufcQJGduGA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:48:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NdBx6tzkT4OwufcQJGduGA/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 08:48:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NdBx6tzkT4OwufcQJGduGA/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 08:48:49 INFO - Downloaded 10840152 bytes. 08:48:49 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'] 08:48:49 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 08:48:50 INFO - Return code: 0 08:48:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:50 INFO - https://queue.taskcluster.net/v1/task/NdBx6tzkT4OwufcQJGduGA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:48:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NdBx6tzkT4OwufcQJGduGA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:48:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NdBx6tzkT4OwufcQJGduGA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:48:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NdBx6tzkT4OwufcQJGduGA/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 08:48:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NdBx6tzkT4OwufcQJGduGA/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 08:48:53 INFO - Downloaded 54866561 bytes. 08:48:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NdBx6tzkT4OwufcQJGduGA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:48:53 INFO - mkdir: /builds/slave/test/properties 08:48:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:48:53 INFO - Writing to file /builds/slave/test/properties/build_url 08:48:53 INFO - Contents: 08:48:53 INFO - build_url:https://queue.taskcluster.net/v1/task/NdBx6tzkT4OwufcQJGduGA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:48:54 INFO - Running post-action listener: _resource_record_post_action 08:48:54 INFO - Running post-action listener: set_extra_try_arguments 08:48:54 INFO - ##### 08:48:54 INFO - ##### Running populate-webroot step. 08:48:54 INFO - ##### 08:48:54 INFO - Running pre-action listener: _resource_record_pre_action 08:48:54 INFO - Running main action method: populate_webroot 08:48:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:48:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:48:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:48:54 INFO - '--tppagecycles', 08:48:54 INFO - '7'], 08:48:54 INFO - 'tests': ['tsvgm']}}, 08:48:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:48:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:48:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:48:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:48:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:48:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:48:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:54 INFO - 'talos_options': ['--disable-e10s'], 08:48:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:48:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:48:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:54 INFO - 'talos_options': ['--disable-e10s'], 08:48:54 INFO - 'tests': ['damp', 'tps']}, 08:48:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:54 INFO - 'tests': ['damp', 'tps']}, 08:48:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:48:54 INFO - 'tests': ['dromaeo_dom']}, 08:48:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:48:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:48:54 INFO - 'tests': ['a11yr', 08:48:54 INFO - 'ts_paint', 08:48:54 INFO - 'tpaint', 08:48:54 INFO - 'sessionrestore', 08:48:54 INFO - 'sessionrestore_no_auto_restore', 08:48:54 INFO - 'tabpaint']}, 08:48:54 INFO - 'other-e10s': {'tests': ['a11yr', 08:48:54 INFO - 'ts_paint', 08:48:54 INFO - 'tpaint', 08:48:54 INFO - 'sessionrestore', 08:48:54 INFO - 'sessionrestore_no_auto_restore', 08:48:54 INFO - 'tabpaint']}, 08:48:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:48:54 INFO - 'ts_paint', 08:48:54 INFO - 'tpaint', 08:48:54 INFO - 'sessionrestore', 08:48:54 INFO - 'sessionrestore_no_auto_restore', 08:48:54 INFO - 'tabpaint']}, 08:48:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:48:54 INFO - 'ts_paint', 08:48:54 INFO - 'tpaint', 08:48:54 INFO - 'sessionrestore', 08:48:54 INFO - 'sessionrestore_no_auto_restore', 08:48:54 INFO - 'tabpaint']}, 08:48:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:48:54 INFO - 'tests': ['a11yr', 08:48:54 INFO - 'ts_paint', 08:48:54 INFO - 'tpaint', 08:48:54 INFO - 'sessionrestore', 08:48:54 INFO - 'sessionrestore_no_auto_restore', 08:48:54 INFO - 'tabpaint']}, 08:48:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:48:54 INFO - 'tests': ['a11yr', 08:48:54 INFO - 'ts_paint', 08:48:54 INFO - 'tpaint', 08:48:54 INFO - 'sessionrestore', 08:48:54 INFO - 'sessionrestore_no_auto_restore', 08:48:54 INFO - 'tabpaint']}, 08:48:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:48:54 INFO - 'tests': ['tsvgx', 08:48:54 INFO - 'tsvgr_opacity', 08:48:54 INFO - 'tart', 08:48:54 INFO - 'tscrollx', 08:48:54 INFO - 'cart']}, 08:48:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:48:54 INFO - 'tsvgr_opacity', 08:48:54 INFO - 'tart', 08:48:54 INFO - 'tscrollx', 08:48:54 INFO - 'cart']}, 08:48:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:54 INFO - 'talos_options': ['--disable-e10s'], 08:48:54 INFO - 'tests': ['tp5o']}, 08:48:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:54 INFO - 'tests': ['tp5o']}, 08:48:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:54 INFO - 'talos_options': ['--disable-e10s', 08:48:54 INFO - '--xperf_path', 08:48:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:48:54 INFO - 'tests': ['tp5n']}, 08:48:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:54 INFO - 'talos_options': ['--xperf_path', 08:48:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:48:54 INFO - 'tests': ['tp5n']}}, 08:48:54 INFO - 'talos.zip': {'path': '', 08:48:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:48:54 INFO - Running post-action listener: _resource_record_post_action 08:48:54 INFO - ##### 08:48:54 INFO - ##### Running create-virtualenv step. 08:48:54 INFO - ##### 08:48:54 INFO - Running pre-action listener: _resource_record_pre_action 08:48:54 INFO - Running main action method: create_virtualenv 08:48:54 INFO - Creating virtualenv /builds/slave/test/build/venv 08:48:54 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:48:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:48:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:48:54 INFO - Using real prefix '/usr' 08:48:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:48:55 INFO - Installing distribute.............................................................................................................................................................................................done. 08:48:57 INFO - Installing pip.................done. 08:48:57 INFO - Return code: 0 08:48:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:48:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:57 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 0x7f92a6558f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055410>, '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 0x1056310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10567a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1462461527.641334-183314310', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:48:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:48:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:48:57 INFO - Using env: {'DISPLAY': ':0', 08:48:57 INFO - 'HOME': '/home/cltbld', 08:48:57 INFO - 'LANG': 'en_US.UTF-8', 08:48:57 INFO - 'LANGUAGE': 'en_US:en', 08:48:57 INFO - 'LOGNAME': 'cltbld', 08:48:57 INFO - 'MAIL': '/var/mail/cltbld', 08:48:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:57 INFO - 'MOZ_NO_REMOTE': '1', 08:48:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:57 INFO - 'NO_EM_RESTART': '1', 08:48:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:57 INFO - 'PWD': '/builds/slave/test', 08:48:57 INFO - 'SHELL': '/bin/bash', 08:48:57 INFO - 'SHLVL': '1', 08:48:57 INFO - 'TERM': 'linux', 08:48:57 INFO - 'TMOUT': '86400', 08:48:57 INFO - 'USER': 'cltbld', 08:48:57 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1462461527.641334-183314310', 08:48:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:57 INFO - '_': '/tools/buildbot/bin/python'} 08:48:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:57 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:48:57 INFO - Cleaning up... 08:48:57 INFO - Return code: 0 08:48:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:48:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:57 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 0x7f92a6558f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055410>, '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 0x1056310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10567a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1462461527.641334-183314310', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:48:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 08:48:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:48:57 INFO - Using env: {'DISPLAY': ':0', 08:48:57 INFO - 'HOME': '/home/cltbld', 08:48:57 INFO - 'LANG': 'en_US.UTF-8', 08:48:57 INFO - 'LANGUAGE': 'en_US:en', 08:48:57 INFO - 'LOGNAME': 'cltbld', 08:48:57 INFO - 'MAIL': '/var/mail/cltbld', 08:48:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:57 INFO - 'MOZ_NO_REMOTE': '1', 08:48:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:57 INFO - 'NO_EM_RESTART': '1', 08:48:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:57 INFO - 'PWD': '/builds/slave/test', 08:48:57 INFO - 'SHELL': '/bin/bash', 08:48:57 INFO - 'SHLVL': '1', 08:48:57 INFO - 'TERM': 'linux', 08:48:57 INFO - 'TMOUT': '86400', 08:48:57 INFO - 'USER': 'cltbld', 08:48:57 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1462461527.641334-183314310', 08:48:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:57 INFO - '_': '/tools/buildbot/bin/python'} 08:48:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:57 INFO - Downloading/unpacking psutil>=0.7.1 08:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:48:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:48:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:48:59 INFO - Installing collected packages: psutil 08:48:59 INFO - Running setup.py install for psutil 08:48:59 INFO - building 'psutil._psutil_linux' extension 08:48:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:48:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:48:59 INFO - building 'psutil._psutil_posix' extension 08:48:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:48:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:49:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:49:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:49:00 INFO - Successfully installed psutil 08:49:00 INFO - Cleaning up... 08:49:00 INFO - Return code: 0 08:49:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:49:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:49:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:49:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:00 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 0x7f92a6558f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055410>, '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 0x1056310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10567a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1462461527.641334-183314310', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:49:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 08:49:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 08:49:00 INFO - Using env: {'DISPLAY': ':0', 08:49:00 INFO - 'HOME': '/home/cltbld', 08:49:00 INFO - 'LANG': 'en_US.UTF-8', 08:49:00 INFO - 'LANGUAGE': 'en_US:en', 08:49:00 INFO - 'LOGNAME': 'cltbld', 08:49:00 INFO - 'MAIL': '/var/mail/cltbld', 08:49:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:00 INFO - 'MOZ_NO_REMOTE': '1', 08:49:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:49:00 INFO - 'NO_EM_RESTART': '1', 08:49:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:49:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:00 INFO - 'PWD': '/builds/slave/test', 08:49:00 INFO - 'SHELL': '/bin/bash', 08:49:00 INFO - 'SHLVL': '1', 08:49:00 INFO - 'TERM': 'linux', 08:49:00 INFO - 'TMOUT': '86400', 08:49:00 INFO - 'USER': 'cltbld', 08:49:00 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1462461527.641334-183314310', 08:49:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:00 INFO - '_': '/tools/buildbot/bin/python'} 08:49:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:49:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:49:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:49:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:49:02 INFO - Installing collected packages: mozsystemmonitor 08:49:02 INFO - Running setup.py install for mozsystemmonitor 08:49:02 INFO - Successfully installed mozsystemmonitor 08:49:02 INFO - Cleaning up... 08:49:02 INFO - Return code: 0 08:49:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:49:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:49:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:02 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 0x7f92a6558f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055410>, '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 0x1056310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10567a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1462461527.641334-183314310', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:49:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:49:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:49:02 INFO - Using env: {'DISPLAY': ':0', 08:49:02 INFO - 'HOME': '/home/cltbld', 08:49:02 INFO - 'LANG': 'en_US.UTF-8', 08:49:02 INFO - 'LANGUAGE': 'en_US:en', 08:49:02 INFO - 'LOGNAME': 'cltbld', 08:49:02 INFO - 'MAIL': '/var/mail/cltbld', 08:49:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:02 INFO - 'MOZ_NO_REMOTE': '1', 08:49:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:49:02 INFO - 'NO_EM_RESTART': '1', 08:49:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:49:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:02 INFO - 'PWD': '/builds/slave/test', 08:49:02 INFO - 'SHELL': '/bin/bash', 08:49:02 INFO - 'SHLVL': '1', 08:49:02 INFO - 'TERM': 'linux', 08:49:02 INFO - 'TMOUT': '86400', 08:49:02 INFO - 'USER': 'cltbld', 08:49:02 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1462461527.641334-183314310', 08:49:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:02 INFO - '_': '/tools/buildbot/bin/python'} 08:49:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:02 INFO - Downloading/unpacking blobuploader==1.2.4 08:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:04 INFO - Downloading blobuploader-1.2.4.tar.gz 08:49:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:49:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:49:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:05 INFO - Downloading docopt-0.6.1.tar.gz 08:49:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:49:05 INFO - Installing collected packages: blobuploader, requests, docopt 08:49:05 INFO - Running setup.py install for blobuploader 08:49:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:49:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:49:05 INFO - Running setup.py install for requests 08:49:05 INFO - Running setup.py install for docopt 08:49:05 INFO - Successfully installed blobuploader requests docopt 08:49:05 INFO - Cleaning up... 08:49:05 INFO - Return code: 0 08:49:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:49: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')]} 08:49:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49: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')]} 08:49:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:05 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 0x7f92a6558f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055410>, '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 0x1056310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10567a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1462461527.641334-183314310', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:49:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:49:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:49:05 INFO - Using env: {'DISPLAY': ':0', 08:49:05 INFO - 'HOME': '/home/cltbld', 08:49:05 INFO - 'LANG': 'en_US.UTF-8', 08:49:05 INFO - 'LANGUAGE': 'en_US:en', 08:49:05 INFO - 'LOGNAME': 'cltbld', 08:49:05 INFO - 'MAIL': '/var/mail/cltbld', 08:49:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:05 INFO - 'MOZ_NO_REMOTE': '1', 08:49:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:49:05 INFO - 'NO_EM_RESTART': '1', 08:49:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:49:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:05 INFO - 'PWD': '/builds/slave/test', 08:49:05 INFO - 'SHELL': '/bin/bash', 08:49:05 INFO - 'SHLVL': '1', 08:49:05 INFO - 'TERM': 'linux', 08:49:05 INFO - 'TMOUT': '86400', 08:49:05 INFO - 'USER': 'cltbld', 08:49:05 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1462461527.641334-183314310', 08:49:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:05 INFO - '_': '/tools/buildbot/bin/python'} 08:49:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:49:06 INFO - Running setup.py (path:/tmp/pip-A7rgb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:49:06 INFO - Running setup.py (path:/tmp/pip-XtZKZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:49:06 INFO - Running setup.py (path:/tmp/pip-yHWHAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:49:06 INFO - Running setup.py (path:/tmp/pip-bmN54N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:49:06 INFO - Running setup.py (path:/tmp/pip-zkySc7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:49:06 INFO - Running setup.py (path:/tmp/pip-m49BGh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:49:06 INFO - Running setup.py (path:/tmp/pip-86G045-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:49:06 INFO - Running setup.py (path:/tmp/pip-7ayCTe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:49:06 INFO - Running setup.py (path:/tmp/pip-I2mgKm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:49:06 INFO - Running setup.py (path:/tmp/pip-RE7kDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:49:06 INFO - Running setup.py (path:/tmp/pip-kiblrc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:49:06 INFO - Running setup.py (path:/tmp/pip-VsXBBn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:49:06 INFO - Running setup.py (path:/tmp/pip-Ig0yGC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:49:07 INFO - Running setup.py (path:/tmp/pip-z2gcMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:49:07 INFO - Running setup.py (path:/tmp/pip-yrwmOp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:49:07 INFO - Running setup.py (path:/tmp/pip-o5Z0nW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:49:07 INFO - Running setup.py (path:/tmp/pip-r1kD5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:49:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:49:07 INFO - Running setup.py install for manifestparser 08:49:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:49:07 INFO - Running setup.py install for mozcrash 08:49:07 INFO - Running setup.py install for mozdebug 08:49:07 INFO - Running setup.py install for mozdevice 08:49:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:49:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:49:07 INFO - Running setup.py install for mozfile 08:49:07 INFO - Running setup.py install for mozhttpd 08:49:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:49:07 INFO - Running setup.py install for mozinfo 08:49:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:49:08 INFO - Running setup.py install for mozInstall 08:49:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:49:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:49:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:49:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:49:08 INFO - Running setup.py install for mozleak 08:49:08 INFO - Running setup.py install for mozlog 08:49:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:49:08 INFO - Running setup.py install for moznetwork 08:49:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:49:08 INFO - Running setup.py install for mozprocess 08:49:08 INFO - Running setup.py install for mozprofile 08:49:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:49:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:49:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:49:08 INFO - Running setup.py install for mozrunner 08:49:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:49:08 INFO - Running setup.py install for mozscreenshot 08:49:08 INFO - Running setup.py install for moztest 08:49:08 INFO - Running setup.py install for mozversion 08:49:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:49:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:49:09 INFO - Cleaning up... 08:49:09 INFO - Return code: 0 08:49:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:49:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:49:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:49:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:09 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 0x7f92a6558f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055410>, '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 0x1056310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10567a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1462461527.641334-183314310', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:49:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:49:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:49:09 INFO - Using env: {'DISPLAY': ':0', 08:49:09 INFO - 'HOME': '/home/cltbld', 08:49:09 INFO - 'LANG': 'en_US.UTF-8', 08:49:09 INFO - 'LANGUAGE': 'en_US:en', 08:49:09 INFO - 'LOGNAME': 'cltbld', 08:49:09 INFO - 'MAIL': '/var/mail/cltbld', 08:49:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:09 INFO - 'MOZ_NO_REMOTE': '1', 08:49:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:49:09 INFO - 'NO_EM_RESTART': '1', 08:49:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:49:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:09 INFO - 'PWD': '/builds/slave/test', 08:49:09 INFO - 'SHELL': '/bin/bash', 08:49:09 INFO - 'SHLVL': '1', 08:49:09 INFO - 'TERM': 'linux', 08:49:09 INFO - 'TMOUT': '86400', 08:49:09 INFO - 'USER': 'cltbld', 08:49:09 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1462461527.641334-183314310', 08:49:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:09 INFO - '_': '/tools/buildbot/bin/python'} 08:49:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:49:09 INFO - Running setup.py (path:/tmp/pip-RcPlt0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:49:09 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:49:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:49:09 INFO - Running setup.py (path:/tmp/pip-YjgW5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:49:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:49:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:49:09 INFO - Running setup.py (path:/tmp/pip-m9s1D7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:49:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:49:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:49:09 INFO - Running setup.py (path:/tmp/pip-rQn6x_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:49:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:49:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:49:09 INFO - Running setup.py (path:/tmp/pip-Egz30O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:49:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:49:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:49:09 INFO - Running setup.py (path:/tmp/pip-oz7i5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:49:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:49:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:49:09 INFO - Running setup.py (path:/tmp/pip-RQ8g6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:49:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:49:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:49:09 INFO - Running setup.py (path:/tmp/pip-zNb7B7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:49:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:49:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:49:09 INFO - Running setup.py (path:/tmp/pip-AT55RG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:49:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:49:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:49:09 INFO - Running setup.py (path:/tmp/pip-w4fDU_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:49:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:49:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:49:10 INFO - Running setup.py (path:/tmp/pip-C_whGu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:49:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:49:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:49:10 INFO - Running setup.py (path:/tmp/pip-QqxlNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:49:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:49:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:49:10 INFO - Running setup.py (path:/tmp/pip-C1_gX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:49:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:49:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:49:10 INFO - Running setup.py (path:/tmp/pip-g2MnHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:49:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:49:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:49:10 INFO - Running setup.py (path:/tmp/pip-fTOY4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:49:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:49:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:49:10 INFO - Running setup.py (path:/tmp/pip-ivc4cW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:49:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:49:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:49:10 INFO - Running setup.py (path:/tmp/pip-w8zc89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:49:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:49:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:49:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:49:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:49:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:49:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:49:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:49:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:12 INFO - Downloading blessings-1.6.tar.gz 08:49:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:49:12 INFO - Installing collected packages: blessings 08:49:12 INFO - Running setup.py install for blessings 08:49:12 INFO - Successfully installed blessings 08:49:12 INFO - Cleaning up... 08:49:12 INFO - Return code: 0 08:49:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:49:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:49:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:49:12 INFO - Reading from file tmpfile_stdout 08:49:12 INFO - Current package versions: 08:49:12 INFO - argparse == 1.2.1 08:49:12 INFO - blessings == 1.6 08:49:12 INFO - blobuploader == 1.2.4 08:49:12 INFO - docopt == 0.6.1 08:49:12 INFO - manifestparser == 1.1 08:49:12 INFO - mozInstall == 1.12 08:49:12 INFO - mozcrash == 0.17 08:49:12 INFO - mozdebug == 0.1 08:49:12 INFO - mozdevice == 0.48 08:49:12 INFO - mozfile == 1.2 08:49:12 INFO - mozhttpd == 0.7 08:49:12 INFO - mozinfo == 0.9 08:49:12 INFO - mozleak == 0.1 08:49:12 INFO - mozlog == 3.1 08:49:12 INFO - moznetwork == 0.27 08:49:12 INFO - mozprocess == 0.22 08:49:12 INFO - mozprofile == 0.28 08:49:12 INFO - mozrunner == 6.11 08:49:12 INFO - mozscreenshot == 0.1 08:49:12 INFO - mozsystemmonitor == 0.0 08:49:12 INFO - moztest == 0.7 08:49:12 INFO - mozversion == 1.4 08:49:12 INFO - psutil == 3.1.1 08:49:12 INFO - requests == 1.2.3 08:49:12 INFO - wsgiref == 0.1.2 08:49:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:49:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:49:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:49:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:12 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 0x7f92a6558f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055410>, '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 0x1056310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10567a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1462461527.641334-183314310', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:49:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:49:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:49:12 INFO - Using env: {'DISPLAY': ':0', 08:49:12 INFO - 'HOME': '/home/cltbld', 08:49:12 INFO - 'LANG': 'en_US.UTF-8', 08:49:12 INFO - 'LANGUAGE': 'en_US:en', 08:49:12 INFO - 'LOGNAME': 'cltbld', 08:49:12 INFO - 'MAIL': '/var/mail/cltbld', 08:49:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:12 INFO - 'MOZ_NO_REMOTE': '1', 08:49:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:49:12 INFO - 'NO_EM_RESTART': '1', 08:49:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:49:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:12 INFO - 'PWD': '/builds/slave/test', 08:49:12 INFO - 'SHELL': '/bin/bash', 08:49:12 INFO - 'SHLVL': '1', 08:49:12 INFO - 'TERM': 'linux', 08:49:12 INFO - 'TMOUT': '86400', 08:49:12 INFO - 'USER': 'cltbld', 08:49:12 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1462461527.641334-183314310', 08:49:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:12 INFO - '_': '/tools/buildbot/bin/python'} 08:49:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:49:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:49:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:49:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:49:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:49:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:49:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:49:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:49:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:49:13 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:49:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:49:13 INFO - Cleaning up... 08:49:13 INFO - Return code: 0 08:49:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:49:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:49:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:49:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:13 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 0x7f92a6558f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055410>, '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 0x1056310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10567a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1462461527.641334-183314310', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:49:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:49:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:49:13 INFO - Using env: {'DISPLAY': ':0', 08:49:13 INFO - 'HOME': '/home/cltbld', 08:49:13 INFO - 'LANG': 'en_US.UTF-8', 08:49:13 INFO - 'LANGUAGE': 'en_US:en', 08:49:13 INFO - 'LOGNAME': 'cltbld', 08:49:13 INFO - 'MAIL': '/var/mail/cltbld', 08:49:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:13 INFO - 'MOZ_NO_REMOTE': '1', 08:49:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:49:13 INFO - 'NO_EM_RESTART': '1', 08:49:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:49:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:13 INFO - 'PWD': '/builds/slave/test', 08:49:13 INFO - 'SHELL': '/bin/bash', 08:49:13 INFO - 'SHLVL': '1', 08:49:13 INFO - 'TERM': 'linux', 08:49:13 INFO - 'TMOUT': '86400', 08:49:13 INFO - 'USER': 'cltbld', 08:49:13 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1462461527.641334-183314310', 08:49:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:13 INFO - '_': '/tools/buildbot/bin/python'} 08:49:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:13 INFO - Downloading/unpacking jsonschema 08:49:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:49:15 INFO - Downloading/unpacking functools32 (from jsonschema) 08:49:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:15 INFO - Downloading functools32-3.2.3-2.tar.gz 08:49:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:49:15 INFO - warning: no files found matching '*.txt' 08:49:15 INFO - no previously-included directories found matching 'build' 08:49:15 INFO - no previously-included directories found matching 'dist' 08:49:15 INFO - no previously-included directories found matching '.git*' 08:49:15 INFO - Installing collected packages: jsonschema, functools32 08:49:15 INFO - Running setup.py install for functools32 08:49:15 INFO - warning: no files found matching '*.txt' 08:49:15 INFO - no previously-included directories found matching 'build' 08:49:15 INFO - no previously-included directories found matching 'dist' 08:49:15 INFO - no previously-included directories found matching '.git*' 08:49:15 INFO - Successfully installed jsonschema functools32 08:49:15 INFO - Cleaning up... 08:49:15 INFO - Return code: 0 08:49:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:49: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')]} 08:49:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49: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')]} 08:49:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92a6558f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xefb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfc65a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055410>, '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 0x1056310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10567a0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1462461527.641334-183314310', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:49: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', 'flake8'] in /builds/slave/test/build 08:49: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 flake8 08:49:15 INFO - Using env: {'DISPLAY': ':0', 08:49:15 INFO - 'HOME': '/home/cltbld', 08:49:15 INFO - 'LANG': 'en_US.UTF-8', 08:49:15 INFO - 'LANGUAGE': 'en_US:en', 08:49:15 INFO - 'LOGNAME': 'cltbld', 08:49:15 INFO - 'MAIL': '/var/mail/cltbld', 08:49:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:15 INFO - 'MOZ_NO_REMOTE': '1', 08:49:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:49:15 INFO - 'NO_EM_RESTART': '1', 08:49:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:49:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:15 INFO - 'PWD': '/builds/slave/test', 08:49:15 INFO - 'SHELL': '/bin/bash', 08:49:15 INFO - 'SHLVL': '1', 08:49:15 INFO - 'TERM': 'linux', 08:49:15 INFO - 'TMOUT': '86400', 08:49:15 INFO - 'USER': 'cltbld', 08:49:15 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1462461527.641334-183314310', 08:49:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:15 INFO - '_': '/tools/buildbot/bin/python'} 08:49:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:15 INFO - Downloading/unpacking flake8 08:49:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:49:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:49:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:49:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:49:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:49:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:49:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:49:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:49:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:49:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:49:18 INFO - no previously-included directories found matching 'docs/_build' 08:49:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:49:18 INFO - Running setup.py install for pep8 08:49:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:49:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:49:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:49:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:49:18 INFO - no previously-included directories found matching 'docs/_build' 08:49:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:49:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:49:18 INFO - Cleaning up... 08:49:18 INFO - Return code: 0 08:49:18 INFO - Running post-action listener: _resource_record_post_action 08:49:18 INFO - Running post-action listener: _start_resource_monitoring 08:49:18 INFO - Starting resource monitoring. 08:49:18 INFO - ##### 08:49:18 INFO - ##### Running install step. 08:49:18 INFO - ##### 08:49:18 INFO - Running pre-action listener: _resource_record_pre_action 08:49:18 INFO - Running main action method: install 08:49:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:49:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:49:18 INFO - Reading from file tmpfile_stdout 08:49:18 INFO - Detecting whether we're running mozinstall >=1.0... 08:49:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:49:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:49:19 INFO - Reading from file tmpfile_stdout 08:49:19 INFO - Output received: 08:49:19 INFO - Usage: mozinstall [options] installer 08:49:19 INFO - Options: 08:49:19 INFO - -h, --help show this help message and exit 08:49:19 INFO - -d DEST, --destination=DEST 08:49:19 INFO - Directory to install application into. [default: 08:49:19 INFO - "/builds/slave/test"] 08:49:19 INFO - --app=APP Application being installed. [default: firefox] 08:49:19 INFO - mkdir: /builds/slave/test/build/application 08:49:19 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'] 08:49:19 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 08:49:34 INFO - Reading from file tmpfile_stdout 08:49:34 INFO - Output received: 08:49:34 INFO - /builds/slave/test/build/application/firefox/firefox 08:49:34 INFO - Running post-action listener: _resource_record_post_action 08:49:34 INFO - ##### 08:49:34 INFO - ##### Running run-tests step. 08:49:34 INFO - ##### 08:49:34 INFO - Running pre-action listener: _resource_record_pre_action 08:49:34 INFO - Running main action method: run_tests 08:49:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:49:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:49:34 INFO - Python 2.7.3 08:49:34 INFO - Return code: 0 08:49:34 INFO - grabbing minidump binary from tooltool 08:49:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:49:34 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 0x1055410>, '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 0x1056310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10567a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:49:34 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:49:34 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:49:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:49:34 INFO - Return code: 0 08:49:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:49:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:49:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:49:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:49:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:49:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:49:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:49:35 INFO - Return code: 0 08:49:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NdBx6tzkT4OwufcQJGduGA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:49:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NdBx6tzkT4OwufcQJGduGA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:49:35 INFO - Using env: {'DISPLAY': ':0', 08:49:35 INFO - 'HOME': '/home/cltbld', 08:49:35 INFO - 'LANG': 'en_US.UTF-8', 08:49:35 INFO - 'LANGUAGE': 'en_US:en', 08:49:35 INFO - 'LOGNAME': 'cltbld', 08:49:35 INFO - 'MAIL': '/var/mail/cltbld', 08:49:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:49:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:49:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:35 INFO - 'MOZ_NO_REMOTE': '1', 08:49:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:49:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:49:35 INFO - 'NO_EM_RESTART': '1', 08:49:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:49:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:35 INFO - 'PWD': '/builds/slave/test', 08:49:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:49:35 INFO - 'SHELL': '/bin/bash', 08:49:35 INFO - 'SHLVL': '1', 08:49:35 INFO - 'TERM': 'linux', 08:49:35 INFO - 'TMOUT': '86400', 08:49:35 INFO - 'USER': 'cltbld', 08:49:35 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1462461527.641334-183314310', 08:49:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:35 INFO - '_': '/tools/buildbot/bin/python'} 08:49:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NdBx6tzkT4OwufcQJGduGA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:49:36 INFO - mozversion application_buildid: 20160505070954 08:49:36 INFO - mozversion application_changeset: 29662e28a9c93ac67ee0b8ddfb65a9f29bbf73f5 08:49:36 INFO - mozversion application_display_name: Nightly 08:49:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:49:36 INFO - mozversion application_name: Firefox 08:49:36 INFO - mozversion application_remotingname: firefox 08:49:36 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:49:36 INFO - mozversion application_vendor: Mozilla 08:49:36 INFO - mozversion application_version: 49.0a1 08:49:36 INFO - mozversion platform_buildid: 20160505070954 08:49:36 INFO - mozversion platform_changeset: 29662e28a9c93ac67ee0b8ddfb65a9f29bbf73f5 08:49:36 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:49:36 INFO - mozversion platform_version: 49.0a1 08:49:36 INFO - using testdate: 1462463376 08:49:36 INFO - actual date: 1462463376 08:49:36 INFO - starting webserver on 'localhost:37177' 08:49:36 INFO - SUITE-START | Running 2 tests 08:49:36 INFO - TEST-START | dromaeo_css 08:49:36 INFO - operating with platform_type : linux_ 08:49:36 INFO - Initialising browser for dromaeo_css test... 08:49:36 INFO - TEST-INFO | started process 12676 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxA1JQV/profile http://localhost:37177/getInfo.html) 08:49:39 INFO - PROCESS | 12676 | __metrics Screen width/height:1600/1200 08:49:39 INFO - PROCESS | 12676 | colorDepth:24 08:49:39 INFO - PROCESS | 12676 | Browser inner width/height: 1024/697 08:49:39 INFO - PROCESS | 12676 | __metrics 08:49:40 ERROR - PROCESS | 12676 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:49:41 INFO - TEST-INFO | 12676: exit 0 08:49:41 INFO - Browser initialized. 08:49:41 INFO - Running cycle 1/1 for dromaeo_css test... 08:49:41 INFO - TEST-INFO | started process 12757 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxA1JQV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:49:53 INFO - PROCESS | 12757 | RSS: Main: 156766208 08:49:53 INFO - PROCESS | 12757 | 08:50:45 INFO - PROCESS | 12757 | 1462463445050 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:52:55 INFO - PROCESS | 12757 | Cycle 1(1): loaded http://localhost:37177/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37177/tests/dromaeo/cssquery-ext.html) 08:52:57 INFO - PROCESS | 12757 | RSS: Main: 232742912 08:52:57 INFO - PROCESS | 12757 | 08:55:59 INFO - PROCESS | 12757 | Cycle 1(1): loaded http://localhost:37177/tests/dromaeo/cssquery-ext.html (next: http://localhost:37177/tests/dromaeo/cssquery-jquery.html) 08:56:00 INFO - PROCESS | 12757 | RSS: Main: 233676800 08:56:00 INFO - PROCESS | 12757 | 08:59:02 INFO - PROCESS | 12757 | Cycle 1(1): loaded http://localhost:37177/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37177/tests/dromaeo/cssquery-mootools.html) 08:59:03 INFO - PROCESS | 12757 | RSS: Main: 245911552 08:59:03 INFO - PROCESS | 12757 | 09:02:05 INFO - PROCESS | 12757 | Cycle 1(1): loaded http://localhost:37177/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37177/tests/dromaeo/cssquery-prototype.html) 09:02:05 INFO - PROCESS | 12757 | RSS: Main: 239910912 09:02:05 INFO - PROCESS | 12757 | 09:05:08 INFO - PROCESS | 12757 | Cycle 1(1): loaded http://localhost:37177/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37177/tests/dromaeo/cssquery-yui.html) 09:05:09 INFO - PROCESS | 12757 | RSS: Main: 213995520 09:05:09 INFO - PROCESS | 12757 | 09:08:12 INFO - PROCESS | 12757 | Cycle 1(1): loaded http://localhost:37177/tests/dromaeo/cssquery-yui.html (next: http://localhost:37177/tests/dromaeo/cssquery-dojo.html) 09:08:12 INFO - PROCESS | 12757 | RSS: Main: 259137536 09:08:12 INFO - PROCESS | 12757 | 09:08:12 INFO - PROCESS | 12757 | __start_tp_report 09:08:12 INFO - PROCESS | 12757 | _x_x_mozilla_page_load 09:08:12 INFO - PROCESS | 12757 | _x_x_mozilla_page_load_details 09:08:12 INFO - PROCESS | 12757 | |i|pagename|runs| 09:08:12 INFO - PROCESS | 12757 | |0;dojo.html;2571.408576027514;2651.5227259093353;2661.880215390307;2664.8934042638293;2678.77230435413;4530.841420550281;4604.493505714373;4608.976955115224;4633.374494443249;4654.162250794856;4616.053708989657;4700.576948074672;4706.058788242357;4734.7869345879435;4763.54746299101;4288.6140247377725;4315.892102697434;4358.673099517533;4389.934150987738;4470.798814053375;4388.890277743066;4427.424434823484;4441.222786012451;4442.289233722605;4452.243118669818;4194.4547208862805;4250.192463431969;4284.700070995032;4299.333603291495;4364.650827933758;4310.418093557361;4343.131373725268;4345.283028300327;4358.869233922956;4399.186150562125;4333.523312435629;4348.673849461303;4351.586599273064;4353.717008394444;4389.648828093745;4361.869143925687;4460.977695111536;4522.5025247222775;4597.517260687613;4610.631149508032;5021.723805190713;5040.193569028937;5063.392392912837;5065.645404821664;5114.156164232897;5047.899042019139;5077.086124497589;5081.314022606938;5083.059633967728;5085;4622.976885115587;4711.764411779397;4741.810327586858;4787.8563643090765;4791.448983366888;5054.519820617035;5055.949440505621;5061.240813877947;5062.696238225644;5066.771995260222;4792.496787837296;4861.51384861511;4863.513648635108;4864.051509955525;4916.164252077156;4871.074495845849;4902;4911.533404326583;4938.654294199371;4941.357623508921;4879.878003049952;4906.515412189926;4908.558229759339;4912.72979986097;4954.355933728664;4804.711717296974;4905.632077594195;4905.852824415273;4907.828226012072;4962.5533701967;4204.264253755642;4230.280852255124;4256.063665993476;4286.464191976003;4297.441332626801;3672.6510981456718;3681.7975011374633;3683.3369993401443;3688.483612294281;3718;4235.915281694349;4319.157764236007;4345.065810850682;4345.456817897762;4375.146846364992;4967.552920237196;4974.626902982291;4976.42771081323;4989.326440930428;5029.924551131736;4320.308750599952;4320.503142138631;4321.935170972438;4338.58783415575;4370.584794444522;4343.131373725268;4445.488768791565;4448.688591798543;4464.933026004613;4542.6593005524055;4728.1252968201;4730.692504987233;4732.100900828831;4758.31004504338;4767.523247675204;4991.700497970133;4995.375578052744;4998.225275082368;5016.372953380827;5057.418396884405;4587.357769912148;4722.244440889442;4743.288506723881;4806.903861922672;4810.903781924272;4978.6763860348965;4995.525425084611;5017.598592112549;5024.748762561931;5073.695578265316;5048.7223202722735;5065.898682026413;5078.7206703631655;5088.363954505687;5090.4073417809;4702.506236845082;4802.519748025309;4838.612910967044;4897.657163998629;4954.232094025432;4776.761161941959;4790.8323208687525;4791.520847915181;4793.424789025339;4838.540338667821;4720.409948756405;4731.905361892812;4737.502562231054;4751.287306903992;4786.497417771084;4677.789499472464;4817.8313759018265;4859.271109333628;4906.362172917497;4915.0415668944215;4703.247480403119;4712.69367491112;4719.244920812654;4720.197566413786;4770.713757174581 09:08:12 INFO - PROCESS | 12757 | |1;ext.html;586.6802592587039;611.5199568338858;613.9355367686393;623.0840664223596;631.807298773874;27229.72770272297;28038.158855234324;28057.43885122299;35415;36363.272734545295;35671.2865742685;36329.27341453169;36353.81823090887;36401.81799091001;36477.27045459089;7449.813754656137;7621.961890190541;7622.961885190594;7628.771136865875;7629.618519074052;7319.231480694503;7629;9412.388194767318;9725.854112188323;9742.074502922247;9870;9968.800623987516;9981.351212171221;9982.151517121054;9985.20118390527;9857.90142098577;9974.750631234205;9986;9986.101250887383;9992.551080093346;9694.563744631509;9857.753556161082;9861.852072218922;9870.2103831694;9877.160441362494;35930.8203458981;36451.27097458063;39712.404313935316;39798.40302395437;39869;3166.208447888028;3357.462805951036;3451.534042904226;3763.247350529905;3778.8299526521373;30359.24101897448;30602.234944126354;30653.620741035153;30694.38611227763;30927.536086958487;3075.4310452566347;3094.8452577371268;3102.9379412411627;3145.874165033396;3202.9679703203137;249590;249995.9999999982;250175;250588;251292;52701;54619.72690136603;54650.72674636601;54797.1780423294;54882.45117548853;51687.74156129195;51748.48251517512;51820.740896295276;51822.22266666003;51941.48058519366;14906.403743850342;15574.299156537983;15611.765823512656;15617.453389131326;15620.375184992701;10005.799884002425;10410.375377477376;11363;11368.602098926498;11379.37413442252;15543.689126217638;15620.218989050729;15631.140287284308;15648.295826687827;15805.36778528869;5895.67573783446;6041.124037014608;6100.481459076028;6176.166217560662;6188.257409110845;943.1605870774879;948.6679662118341;985.4235272365603;1006.5470538257667;1085.636311835544;27555.448891022068;28642.856785716354;28966.69649865761;29390.559141612892;29448.263793405335;966.2801213096288;1043.4678314059884;1069.3476979042778;1115.8549388579434;1153.8557680289964;15091;15132.167730774912;15469.922650386676;15602.375904963674;15738.449154279546;347407;351405;353694;355634;355707;51651;52602.473975260524;52655.47344526582;52827.73586132045;52833.47166528286;1112.7663190729875;1203.7351782607811;1272.9172603780726;1276.546825876819;1287.7939529675393;26138.73861261363;28465.857670711513;28779.712202877705;28837.27906802347;29205.123846284645;40224.798876005436;40630.59369406268;40646.18707625772;40667;40683.3897491532;198217;201866;201929;202336;202468;27833.443331132858;28601;29425.11724648264;29450.558241625964;29464.852675736485;37962.240755185296;38240.80879595584;38342.616573833904;38360.80819595884;39075.80462097671;31849.68150318467;32855.83572082124;33076.83461582677;33131.52724382274;33884.152896177795;32577.674223257465;33856.83071584626;36133.63866361303;36208.275834482636;36416.08959776027;35281.294374112884;35842.82078589591;35956;36062.4590631146;36085.27829443344;31530.684693152776;32130.83934580312;32295.35409291848;32365;32579.67420325861;24825.1311204107;24943;25065.87467062653;25421.237362879143;25494.235172944842 09:08:12 INFO - PROCESS | 12757 | |2;jquery.html;378.09257781324817;383.0978046700021;383.60488696642454;384.753757595139;387.7072810028428;15933.203339833006;16289.674206515863;17311.22099505522;17326.82673173268;17418.216180271887;11284.830727539094;15988.12065336406;16712.331506739716;16765.245563949622;16765.413210537634;3482.564679415073;4566.337881007244;4751.382320298357;4759.405074365704;4764.642651801111;3585.8207089645543;5206.687598744087;5460.372057213432;5469.07025805614;5474.7810087596445;5432.293801805779;5437.429069947638;5444.891102177954;5453.945460545384;5559.360673522536;5881.4118588141055;5898.8230353089475;5914.8817023659285;5921.171036054977;5931.110333449974;5159.58723302135;5270.525652691238;5283.07546179417;5317.335333083364;5432.103702889019;12893.806592901114;12945.741085178337;12996;13119.212847229197;17279.395221167324;1852.5183452302363;2019.5859848730975;2053.435305291042;2071.730675012239;2105.0632468551503;8884.911150888473;9132.543372831398;9141.588628511667;11600.361980091091;13269.535566255136;1648;1684.3599432215801;1701.3619892540298;1728.4987353667548;1774.370098614986;66287;69473.3052669472;71604.6419767903;72057.27942720558;72200.2779972204;10071.446070466194;10198.541065652063;10301;10404.531796069195;10464.319819211727;14522.346494407777;14549.34527946245;14568.49010284635;14610;14622.634434139232;6875;7040.683169257396;7223.566586004857;7254.709811607582;7276.054112965387;6302.180716506825;6430.164078669743;6466.773662921869;6597.670116494252;6784.321567843176;4184.623383895464;4289.914201715948;4306.483222013316;4337.783110844445;4419.580139886705;1662.4347721774413;1769.8938063716218;1855.1559040636478;1901.7923618502075;1910.4650697804636;397.48128692056565;867.1935100356728;884.8276034254638;1026.7022563456514;1041.8955906738881;9929.304948653526;16170.434034808724;17415.303387864344;17729.37947171843;17914.91042544805;864.6498168241872;881.6825942660637;904.6291020681489;926.5552534783342;952.4285428742837;9369.672061477952;9535.570899309549;9828.21291639701;10131.949340253399;10195.082442580204;292994;307399;308642;309369;416907;74733;78060.21939780643;78808;78984;81885;950.8763860698065;952.2524818017823;992.6327258914104;993.9503024848729;996.3523709588825;15640.530784076496;15879.52361429159;15999.440019599258;16086.034837909763;16310.918445407697;34130;34832.30335393328;35021;35208.11979700528;35727.106822329646;47888.5211147898;48869;50361.244581330575;50406.24390634217;50479.747601261755;7353.963230183815;7473.88789168152;7487.925120748723;7536.660850261861;7597.392208623186;10103.797924041331;10115.59537618487;10738.946305268424;10813.459327033774;11415.60045398407;9405.81188376215;9511.143997040299;9713.262185234717;10298.794024119326;10427.322224055411;10061.547230374505;10193.898061019296;10200.80682653233;10247;10566.788664226826;10143.28996970205;10353.741156470847;10366.429846358522;10387.68836934893;10478.685639430829;7431.071116110486;7716.8456630868195;7738.729144479917;7848.450608457353;7973.20267973198;9997.600095996078;10343.94828025855;10453.581856725647;10515.26393152472;10550.788984220426 09:08:12 INFO - PROCESS | 12757 | |3;mootools.html;1307.6992291772885;1486.7472529669958;1498.6553092788658;1655.3047719957617;1810.415377552447;7047.400970917472;7342.3758980486655;7347;7355.521891077076;7360.889586656191;7035.718571257144;7246.058012458373;7288.817779555514;7292.38014768744;7306.634668266592;1830.2130084063847;2109.789021097893;2166.166026079955;2179.3570896585547;2195.9560808783895;2196.0447205465675;2201.7798220177933;2207.4040009197506;2208.116753298685;2209.4255493571627;2122.7771084036185;2194.58302922445;2194.9903044599505;2199.362184966366;2201.2625770366867;1798.8111248318935;2107.7892210778955;2148.44140523465;2157.622416077196;2158.4064382294837;2080.552681173555;2083.2396175396025;2103.5267064910427;2104.3581707579183;2104.6737755647746;7158.570485770871;7249.492535522516;7341.77974660761;7342.265773422669;7344.632768361561;4314.223439780838;4524.140413321491;4528.773561321921;4534.31985202219;4543;2769.9307517312027;2831.8725657345467;2891.927701807451;2892.754115900151;2908.9127326180246;906.2206502407923;919.5448253114685;923.4044041593202;937.2455173585261;947.4788866123605;10160;10201.74495637615;10204.97950204981;10222.693319200436;10235.692929212135;4089.97955010229;4160.875173744793;4233.433629557022;4278.507971583308;4283.164782867311;8787.077356877564;8820.77948051291;8832.77918052041;8853.468791872509;8871.556422178865;3890.5525864525944;4490.101979604092;4507.887302817456;4515.571020753023;4517.887052823706;3981.6217459341315;4017;4039.8788036358956;4069.7965101744794;4072.2466343726505;3438.3123375324535;3484.285721427152;3533.1697051193464;3535.840887160084;3587.9103022424647;1177.617274385828;1186;1191.4697959408154;1195.109643315718;1196.282230661596;817.3338728935898;818.893543839309;826.7437094500724;832.1871725993927;846.2003406780533;4907.337509436252;5127.769250383742;5138.203578445347;5151.639385242997;5293.761780719877;934.9532523373804;946.6071580294239;978.2125389061873;981.1709105805583;992.6277645882794;3423.863045478203;3431.4852772084387;3454.378211921878;3497.0732755819727;3512;8848.1151884811;9092.045335239836;9208.677696280598;9213.63145474187;9237.030111838294;8994.05562415937;9008.954955225181;9047.864282035775;9076.41003334781;9095.954520227357;6915.723371065202;7131.001659767637;7167.641617919083;7181;7206;4819.421669399554;4980.477049909708;5019.272205530105;5037.722925239147;5107.055194788976;8256.298214651822;8400.075991640793;8454.704085356983;8494.065652778067;8504.574771261288;8496.745097647081;8521.91478085236;8552.358573106918;8553.31573474133;8673.089325620971;5325.920111198413;5334.1732031535175;5469.671819690831;5802.535797136304;5921.703914804329;6974;7114;7126.429885609035;7128.429725621834;7131.572105673677;6332.810015699536;6581.80254592363;6601.306862779531;6648.83377915556;6710.261871194262;6463.385978332051;6511.3163117871945;6526.804195874131;6552.508561857975;6641.435477984425;5906.852328691817;6098.634081955097;6098.695065246809;6102.0541816018585;6104.4200800923845;4373.190959672471;4434.3791869138995;4445.955540444555;4573.451185857718;4594.310853372021;4426.313921342197;4464.709793863389;4477.373167756582;4552.385427967182;4592.816287348469 09:08:12 INFO - PROCESS | 12757 | |4;prototype.html;313.31696900756356;315.25914101860633;317.33043278681976;317.8760283489438;319.24657807574135;4652.441706995161;4736.608012953458;4764.166270902596;4765.428148622166;4805.951940480594;4699.577038066574;4707.435107787071;4713.646476514258;4713.835015774449;4738.763061846903;3541.3271478419147;3657.689096426807;3669.431238158076;3772.717046221531;3782.186829831586;3763.7553559018575;3764.623537646241;3780.508533890604;3797.7721336719887;3806.2301030021035;3552.9111772205642;3758.530183727034;3773.283076215524;3775.2260786538695;3788.3938569828833;3625.546806649169;3783.2244389900006;3789.7872680742175;3793.981030094832;3795.064517096287;3375.3418083473734;3376.2234686022107;3377.240120972786;3388.136025313554;3395.779274347184;4511.909761804745;4522.773861306921;4523.615492683126;4529.932051019237;4545.36364908913;3941.408788681692;4178.874633760992;4184.246835569596;4308.892277693051;4322.654187664979;4869.732164730938;4873.415190177166;4884.926726099111;4906;4909.852704418873;3531.4349704047486;3573.7319701022266;3582.8566857325677;3584.4981702561663;3587.318409502186;4962.354893863775;5069.264956581312;5144.43411224765;5147.7683504242395;5151.300070976568;3631.9092022699115;3643.6720695137033;3650.9452358214116;3658.762180458262;3676.117731744416;3688.4692852466465;3693.9445908311395;3697.815109244527;3701.8704345348324;3706.258748250307;4155.667546596265;4171.018766086085;4183.602557757008;4213.734355874222;4219.45147130871;4641.907161856744;4935.777889994959;4942.9752851236235;4953.306537084811;4989.725565093955;1306.4578200046874;1308.2739079810797;1315.4606611289516;1318.182726709427;1320.0891384944357;838.7064527415356;871.3116637856023;899.2446345070173;921.893982192043;930.3719989007393;4637.8840528986375;4645.233536466445;4660.091282200006;4664.137134630037;4674.368960190399;5305.143199880088;5323;5324.92012619811;5334;5352.839414817562;4537.795799189044;4596.540345965377;4626.97686511572;4636.629069674418;4651.162790697707;2838.758705510055;2843.232327271625;2850.629418175624;2872.956905646417;2874.3963767609034;5057.974710126426;5085.313482679865;5092.719900405439;5094.337736094284;5109.156989096832;5352.946470535323;5485.588580856452;5497.36780270274;5510;5515.365732940683;5075.593952483792;5076.18780995039;5100.183970564692;5111.923321150186;5121.2574176744165;5325.254464375068;5369.1140961740875;5391.487808658171;5393.946060539344;5399.163129714901;5082.390113186441;5255.185446255837;5263.842084737464;5268.762905669178;5290.232916227203;5045.7981680732355;5065.924011139762;5078.111330517218;5078.873028174177;5090.109230884655;3831.2912111259507;3839.4816699746293;3842.5965273646984;3842.9807850960565;3858.6141385861188;5232.895342093061;5333.573314134937;5358.705271210121;5370.812021579226;5373.919391209057;5158.664686795346;5186.144286192736;5204.921926171186;5205.245239440335;5210.140326846028;5107.41264754558;5166.741662916915;5173.042987047408;5209.71346575942;5218.269442278008;4593.6554758392585;5068;5164.018836421068;5164.9741751291;5166.1254059455405;4777.355057067391;4939.950600494093;4969.254611808257;4984.426790918946;5004.874878128076;4853.689503834015;4868.713618307557;4882.267659851051;4887.997960418177;4889.266610008527 09:08:12 INFO - PROCESS | 12757 | |5;yui.html;756.2210922749568;786.9842603147936;800.5396896784343;804.5534728225836;813.3899575318511;11108.666739997803;11326.377049262297;11474.311541307527;11495.310281383123;11526.769464610703;11570.942145289282;11594.362310072942;11621.418929053534;11681.824772628417;11707.356095414749;662.3244290823382;798.0662624729081;828.6892415344261;840.3865178419758;849.600687676794;835.3526017336552;845.7970087179064;846.5301757524571;848.0925409811504;850.2305413600701;897.6499165325496;899.703097977669;899.9775005624846;900.1268769293807;900.7522931193942;699.8215455058953;860.5525126933959;884.9955750221272;886.6187539358074;895.2882458445551;650.5901282192236;651.0787236060968;653.1052458132389;653.4282502810041;653.4478365780908;12238.938805306005;12330.075244356709;12332.630021099292;12348.135630505778;12353.75292494154;11823.172377933548;12508.624741257778;12513.311767852765;12756.107072504929;13067.215967041913;9467.763305917339;9496.762580935463;9544.188743956773;9567.617295308179;9723;3328.7170590499836;3418.435958066916;3418.743594230418;3455.6544345565494;3534.452159915217;40250.59749402498;40359.7982010091;40815.59184408148;40899.591004089874;40953.180936381104;9689.079537443931;10378.844317335246;10492.21308401873;10492.26554141218;10559.366438013743;18309.45071647853;18322.633547329246;18332.266709331478;18337.541561460803;18348.357807476943;6745.258021617618;6756.797296081126;6802.217744959294;6812.6934287957165;6860.451163906875;3746.5316835395574;3828.559715632738;3833.9808300958875;3887.2419878123496;3990.10222699896;2936.295289130636;2995.8052726572705;3006;3008.7743419243643;3020.7281344678645;476.0431532619391;493.8518444466646;509.4319833385748;513.6070905757099;533.4665334665335;574.4973148495067;581.528961541153;588.2294194605081;612.9785457508966;618.6690120785358;7757.146713861471;7776.455648104691;7789.961050194826;8090.555019473985;8139.348852091818;599.4544964082664;599.4994179859866;600.1118344849647;633.9873202535923;634.2294112653057;3442.9827850860584;3707.94438083429;3767.2088861339425;3805.334066538345;3820;52641.7367913158;53981.1902821458;54109.729451353276;54376;54584.72707636436;45516.544834551896;46383.30425043627;46694.76652616715;47763.522364775905;48703.26945095755;42914.57085429106;43467.565324346986;43625.78187109044;44041.559584403745;44081;7365.8526829462035;7511.586862722603;7580.689108518534;7626.122995855548;7663.693452261847;26448.20655380342;27140;27788.583171252852;27797.44405111927;28570;35810.82094589614;36068.27863442664;36116;36708.26583468262;37026.62973370232;10751.19366047534;10759.569617215224;11141.16441266892;11145.164112691418;11292.266002709797;9331.503988986888;11958.64124076279;11985.880141198826;12547.3098979557;12626.810597840857;10514.474276286002;11592;11599.103018610858;11609.709757255798;11668.358240296526;11420.30364292241;11478;11669.649910502698;11750.70623234426;11897.643070707893;11451;11610.88389116098;11648.126390520576;11996.160268781101;12140.33228172459;8898.4660920345;9009.306184464338;9275.907240927505;9303.953480232827;9454.101860323259;9378.437293762123;9599.184069354184;9731.172850307803;9833.508324583885;9848.518789544369 09:08:12 INFO - PROCESS | 12757 | __end_tp_report 09:08:12 INFO - PROCESS | 12757 | __start_cc_report 09:08:12 INFO - PROCESS | 12757 | _x_x_mozilla_cycle_collect,1060 09:08:12 INFO - PROCESS | 12757 | __end_cc_report 09:08:12 INFO - PROCESS | 12757 | __startTimestamp1462464492482__endTimestamp 09:08:12 INFO - PROCESS | 12757 | 09:08:12 INFO - PROCESS | 12757 | ------- Summary: start ------- 09:08:12 INFO - PROCESS | 12757 | Number of tests: 6 09:08:12 INFO - PROCESS | 12757 | 09:08:12 INFO - PROCESS | 12757 | [#0] dojo.html Cycles:165 Average:4615.79 Median:4732.10 stddev:471.43 (10.0%) stddev-sans-first:444.77 09:08:12 INFO - PROCESS | 12757 | Values: 2571.4 2651.5 2661.9 2664.9 2678.8 4530.8 4604.5 4609.0 4633.4 4654.2 4616.1 4700.6 4706.1 4734.8 4763.5 4288.6 4315.9 4358.7 4389.9 4470.8 4388.9 4427.4 4441.2 4442.3 4452.2 4194.5 4250.2 4284.7 4299.3 4364.7 4310.4 4343.1 4345.3 4358.9 4399.2 4333.5 4348.7 4351.6 4353.7 4389.6 4361.9 4461.0 4522.5 4597.5 4610.6 5021.7 5040.2 5063.4 5065.6 5114.2 5047.9 5077.1 5081.3 5083.1 5085.0 4623.0 4711.8 4741.8 4787.9 4791.4 5054.5 5055.9 5061.2 5062.7 5066.8 4792.5 4861.5 4863.5 4864.1 4916.2 4871.1 4902.0 4911.5 4938.7 4941.4 4879.9 4906.5 4908.6 4912.7 4954.4 4804.7 4905.6 4905.9 4907.8 4962.6 4204.3 4230.3 4256.1 4286.5 4297.4 3672.7 3681.8 3683.3 3688.5 3718.0 4235.9 4319.2 4345.1 4345.5 4375.1 4967.6 4974.6 4976.4 4989.3 5029.9 4320.3 4320.5 4321.9 4338.6 4370.6 4343.1 4445.5 4448.7 4464.9 4542.7 4728.1 4730.7 4732.1 4758.3 4767.5 4991.7 4995.4 4998.2 5016.4 5057.4 4587.4 4722.2 4743.3 4806.9 4810.9 4978.7 4995.5 5017.6 5024.7 5073.7 5048.7 5065.9 5078.7 5088.4 5090.4 4702.5 4802.5 4838.6 4897.7 4954.2 4776.8 4790.8 4791.5 4793.4 4838.5 4720.4 4731.9 4737.5 4751.3 4786.5 4677.8 4817.8 4859.3 4906.4 4915.0 4703.2 4712.7 4719.2 4720.2 4770.7 09:08:12 INFO - PROCESS | 12757 | 09:08:12 INFO - PROCESS | 12757 | [#1] ext.html Cycles:180 Average:42936.33 Median:193343.15 stddev:72195.78 (37.3%) stddev-sans-first:72328.29 09:08:12 INFO - PROCESS | 12757 | Values: 586.7 611.5 613.9 623.1 631.8 27229.7 28038.2 28057.4 35415.0 36363.3 35671.3 36329.3 36353.8 36401.8 36477.3 7449.8 7622.0 7623.0 7628.8 7629.6 7319.2 7629.0 9412.4 9725.9 9742.1 9870.0 9968.8 9981.4 9982.2 9985.2 9857.9 9974.8 9986.0 9986.1 9992.6 9694.6 9857.8 9861.9 9870.2 9877.2 35930.8 36451.3 39712.4 39798.4 39869.0 3166.2 3357.5 3451.5 3763.2 3778.8 30359.2 30602.2 30653.6 30694.4 30927.5 3075.4 3094.8 3102.9 3145.9 3203.0 249590.0 249996.0 250175.0 250588.0 251292.0 52701.0 54619.7 54650.7 54797.2 54882.5 51687.7 51748.5 51820.7 51822.2 51941.5 14906.4 15574.3 15611.8 15617.5 15620.4 10005.8 10410.4 11363.0 11368.6 11379.4 15543.7 15620.2 15631.1 15648.3 15805.4 5895.7 6041.1 6100.5 6176.2 6188.3 943.2 948.7 985.4 1006.5 1085.6 27555.4 28642.9 28966.7 29390.6 29448.3 966.3 1043.5 1069.3 1115.9 1153.9 15091.0 15132.2 15469.9 15602.4 15738.4 347407.0 351405.0 353694.0 355634.0 355707.0 51651.0 52602.5 52655.5 52827.7 52833.5 1112.8 1203.7 1272.9 1276.5 1287.8 26138.7 28465.9 28779.7 28837.3 29205.1 40224.8 40630.6 40646.2 40667.0 40683.4 198217.0 201866.0 201929.0 202336.0 202468.0 27833.4 28601.0 29425.1 29450.6 29464.9 37962.2 38240.8 38342.6 38360.8 39075.8 31849.7 32855.8 33076.8 33131.5 33884.2 32577.7 33856.8 36133.6 36208.3 36416.1 35281.3 35842.8 35956.0 36062.5 36085.3 31530.7 32130.8 32295.4 32365.0 32579.7 24825.1 24943.0 25065.9 25421.2 25494.2 09:08:12 INFO - PROCESS | 12757 | 09:08:12 INFO - PROCESS | 12757 | [#2] jquery.html Cycles:180 Average:22307.42 Median:386.23 stddev:55074.46 (14259.5%) stddev-sans-first:55204.34 09:08:12 INFO - PROCESS | 12757 | Values: 378.1 383.1 383.6 384.8 387.7 15933.2 16289.7 17311.2 17326.8 17418.2 11284.8 15988.1 16712.3 16765.2 16765.4 3482.6 4566.3 4751.4 4759.4 4764.6 3585.8 5206.7 5460.4 5469.1 5474.8 5432.3 5437.4 5444.9 5453.9 5559.4 5881.4 5898.8 5914.9 5921.2 5931.1 5159.6 5270.5 5283.1 5317.3 5432.1 12893.8 12945.7 12996.0 13119.2 17279.4 1852.5 2019.6 2053.4 2071.7 2105.1 8884.9 9132.5 9141.6 11600.4 13269.5 1648.0 1684.4 1701.4 1728.5 1774.4 66287.0 69473.3 71604.6 72057.3 72200.3 10071.4 10198.5 10301.0 10404.5 10464.3 14522.3 14549.3 14568.5 14610.0 14622.6 6875.0 7040.7 7223.6 7254.7 7276.1 6302.2 6430.2 6466.8 6597.7 6784.3 4184.6 4289.9 4306.5 4337.8 4419.6 1662.4 1769.9 1855.2 1901.8 1910.5 397.5 867.2 884.8 1026.7 1041.9 9929.3 16170.4 17415.3 17729.4 17914.9 864.6 881.7 904.6 926.6 952.4 9369.7 9535.6 9828.2 10131.9 10195.1 292994.0 307399.0 308642.0 309369.0 416907.0 74733.0 78060.2 78808.0 78984.0 81885.0 950.9 952.3 992.6 994.0 996.4 15640.5 15879.5 15999.4 16086.0 16310.9 34130.0 34832.3 35021.0 35208.1 35727.1 47888.5 48869.0 50361.2 50406.2 50479.7 7354.0 7473.9 7487.9 7536.7 7597.4 10103.8 10115.6 10738.9 10813.5 11415.6 9405.8 9511.1 9713.3 10298.8 10427.3 10061.5 10193.9 10200.8 10247.0 10566.8 10143.3 10353.7 10366.4 10387.7 10478.7 7431.1 7716.8 7738.7 7848.5 7973.2 9997.6 10343.9 10453.6 10515.3 10550.8 09:08:12 INFO - PROCESS | 12757 | 09:08:12 INFO - PROCESS | 12757 | [#3] mootools.html Cycles:180 Average:4920.41 Median:5117.41 stddev:2694.94 (52.7%) stddev-sans-first:2688.82 09:08:12 INFO - PROCESS | 12757 | Values: 1307.7 1486.7 1498.7 1655.3 1810.4 7047.4 7342.4 7347.0 7355.5 7360.9 7035.7 7246.1 7288.8 7292.4 7306.6 1830.2 2109.8 2166.2 2179.4 2196.0 2196.0 2201.8 2207.4 2208.1 2209.4 2122.8 2194.6 2195.0 2199.4 2201.3 1798.8 2107.8 2148.4 2157.6 2158.4 2080.6 2083.2 2103.5 2104.4 2104.7 7158.6 7249.5 7341.8 7342.3 7344.6 4314.2 4524.1 4528.8 4534.3 4543.0 2769.9 2831.9 2891.9 2892.8 2908.9 906.2 919.5 923.4 937.2 947.5 10160.0 10201.7 10205.0 10222.7 10235.7 4090.0 4160.9 4233.4 4278.5 4283.2 8787.1 8820.8 8832.8 8853.5 8871.6 3890.6 4490.1 4507.9 4515.6 4517.9 3981.6 4017.0 4039.9 4069.8 4072.2 3438.3 3484.3 3533.2 3535.8 3587.9 1177.6 1186.0 1191.5 1195.1 1196.3 817.3 818.9 826.7 832.2 846.2 4907.3 5127.8 5138.2 5151.6 5293.8 935.0 946.6 978.2 981.2 992.6 3423.9 3431.5 3454.4 3497.1 3512.0 8848.1 9092.0 9208.7 9213.6 9237.0 8994.1 9009.0 9047.9 9076.4 9096.0 6915.7 7131.0 7167.6 7181.0 7206.0 4819.4 4980.5 5019.3 5037.7 5107.1 8256.3 8400.1 8454.7 8494.1 8504.6 8496.7 8521.9 8552.4 8553.3 8673.1 5325.9 5334.2 5469.7 5802.5 5921.7 6974.0 7114.0 7126.4 7128.4 7131.6 6332.8 6581.8 6601.3 6648.8 6710.3 6463.4 6511.3 6526.8 6552.5 6641.4 5906.9 6098.6 6098.7 6102.1 6104.4 4373.2 4434.4 4446.0 4573.5 4594.3 4426.3 4464.7 4477.4 4552.4 4592.8 09:08:12 INFO - PROCESS | 12757 | 09:08:12 INFO - PROCESS | 12757 | [#4] prototype.html Cycles:180 Average:4227.64 Median:4713.74 stddev:1231.28 (26.1%) stddev-sans-first:1199.17 09:08:12 INFO - PROCESS | 12757 | Values: 313.3 315.3 317.3 317.9 319.2 4652.4 4736.6 4764.2 4765.4 4806.0 4699.6 4707.4 4713.6 4713.8 4738.8 3541.3 3657.7 3669.4 3772.7 3782.2 3763.8 3764.6 3780.5 3797.8 3806.2 3552.9 3758.5 3773.3 3775.2 3788.4 3625.5 3783.2 3789.8 3794.0 3795.1 3375.3 3376.2 3377.2 3388.1 3395.8 4511.9 4522.8 4523.6 4529.9 4545.4 3941.4 4178.9 4184.2 4308.9 4322.7 4869.7 4873.4 4884.9 4906.0 4909.9 3531.4 3573.7 3582.9 3584.5 3587.3 4962.4 5069.3 5144.4 5147.8 5151.3 3631.9 3643.7 3650.9 3658.8 3676.1 3688.5 3693.9 3697.8 3701.9 3706.3 4155.7 4171.0 4183.6 4213.7 4219.5 4641.9 4935.8 4943.0 4953.3 4989.7 1306.5 1308.3 1315.5 1318.2 1320.1 838.7 871.3 899.2 921.9 930.4 4637.9 4645.2 4660.1 4664.1 4674.4 5305.1 5323.0 5324.9 5334.0 5352.8 4537.8 4596.5 4627.0 4636.6 4651.2 2838.8 2843.2 2850.6 2873.0 2874.4 5058.0 5085.3 5092.7 5094.3 5109.2 5352.9 5485.6 5497.4 5510.0 5515.4 5075.6 5076.2 5100.2 5111.9 5121.3 5325.3 5369.1 5391.5 5393.9 5399.2 5082.4 5255.2 5263.8 5268.8 5290.2 5045.8 5065.9 5078.1 5078.9 5090.1 3831.3 3839.5 3842.6 3843.0 3858.6 5232.9 5333.6 5358.7 5370.8 5373.9 5158.7 5186.1 5204.9 5205.2 5210.1 5107.4 5166.7 5173.0 5209.7 5218.3 4593.7 5068.0 5164.0 5165.0 5166.1 4777.4 4940.0 4969.3 4984.4 5004.9 4853.7 4868.7 4882.3 4888.0 4889.3 09:08:12 INFO - PROCESS | 12757 | 09:08:12 INFO - PROCESS | 12757 | [#5] yui.html Cycles:180 Average:12621.96 Median:43833.67 stddev:14174.95 (32.3%) stddev-sans-first:14186.71 09:08:12 INFO - PROCESS | 12757 | Values: 756.2 787.0 800.5 804.6 813.4 11108.7 11326.4 11474.3 11495.3 11526.8 11570.9 11594.4 11621.4 11681.8 11707.4 662.3 798.1 828.7 840.4 849.6 835.4 845.8 846.5 848.1 850.2 897.6 899.7 900.0 900.1 900.8 699.8 860.6 885.0 886.6 895.3 650.6 651.1 653.1 653.4 653.4 12238.9 12330.1 12332.6 12348.1 12353.8 11823.2 12508.6 12513.3 12756.1 13067.2 9467.8 9496.8 9544.2 9567.6 9723.0 3328.7 3418.4 3418.7 3455.7 3534.5 40250.6 40359.8 40815.6 40899.6 40953.2 9689.1 10378.8 10492.2 10492.3 10559.4 18309.5 18322.6 18332.3 18337.5 18348.4 6745.3 6756.8 6802.2 6812.7 6860.5 3746.5 3828.6 3834.0 3887.2 3990.1 2936.3 2995.8 3006.0 3008.8 3020.7 476.0 493.9 509.4 513.6 533.5 574.5 581.5 588.2 613.0 618.7 7757.1 7776.5 7790.0 8090.6 8139.3 599.5 599.5 600.1 634.0 634.2 3443.0 3707.9 3767.2 3805.3 3820.0 52641.7 53981.2 54109.7 54376.0 54584.7 45516.5 46383.3 46694.8 47763.5 48703.3 42914.6 43467.6 43625.8 44041.6 44081.0 7365.9 7511.6 7580.7 7626.1 7663.7 26448.2 27140.0 27788.6 27797.4 28570.0 35810.8 36068.3 36116.0 36708.3 37026.6 10751.2 10759.6 11141.2 11145.2 11292.3 9331.5 11958.6 11985.9 12547.3 12626.8 10514.5 11592.0 11599.1 11609.7 11668.4 11420.3 11478.0 11669.6 11750.7 11897.6 11451.0 11610.9 11648.1 11996.2 12140.3 8898.5 9009.3 9275.9 9304.0 9454.1 9378.4 9599.2 9731.2 9833.5 9848.5 09:08:12 INFO - PROCESS | 12757 | -------- Summary: end -------- 09:08:12 INFO - PROCESS | 12757 | 09:08:13 INFO - TEST-INFO | 12757: exit 0 09:08:13 INFO - TEST-OK | dromaeo_css | took 1117208ms 09:08:13 INFO - TEST-START | kraken 09:08:13 INFO - operating with platform_type : linux_ 09:08:13 INFO - Initialising browser for kraken test... 09:08:13 INFO - TEST-INFO | started process 12937 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9j3Ayf/profile http://localhost:37177/getInfo.html) 09:08:16 INFO - PROCESS | 12937 | __metrics Screen width/height:1600/1200 09:08:16 INFO - PROCESS | 12937 | colorDepth:24 09:08:16 INFO - PROCESS | 12937 | Browser inner width/height: 1024/697 09:08:16 INFO - PROCESS | 12937 | __metrics 09:08:17 ERROR - PROCESS | 12937 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:08:18 INFO - TEST-INFO | 12937: exit 0 09:08:18 INFO - Browser initialized. 09:08:18 INFO - Running cycle 1/1 for kraken test... 09:08:18 INFO - TEST-INFO | started process 13017 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9j3Ayf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:08:30 INFO - PROCESS | 13017 | RSS: Main: 157057024 09:08:30 INFO - PROCESS | 13017 | 09:08:33 INFO - PROCESS | 13017 | Cycle 1(1): loaded http://localhost:37177/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37177/tests/kraken/driver.html?testName=audio-beat-detection) 09:08:34 INFO - PROCESS | 13017 | RSS: Main: 210751488 09:08:34 INFO - PROCESS | 13017 | 09:08:36 INFO - PROCESS | 13017 | Cycle 1(1): loaded http://localhost:37177/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37177/tests/kraken/driver.html?testName=audio-dft) 09:08:37 INFO - PROCESS | 13017 | RSS: Main: 197996544 09:08:37 INFO - PROCESS | 13017 | 09:08:40 INFO - PROCESS | 13017 | Cycle 1(1): loaded http://localhost:37177/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37177/tests/kraken/driver.html?testName=audio-fft) 09:08:41 INFO - PROCESS | 13017 | RSS: Main: 266674176 09:08:41 INFO - PROCESS | 13017 | 09:08:43 INFO - PROCESS | 13017 | Cycle 1(1): loaded http://localhost:37177/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37177/tests/kraken/driver.html?testName=audio-oscillator) 09:08:44 INFO - PROCESS | 13017 | RSS: Main: 176025600 09:08:44 INFO - PROCESS | 13017 | 09:08:46 INFO - PROCESS | 13017 | Cycle 1(1): loaded http://localhost:37177/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37177/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:08:46 INFO - PROCESS | 13017 | RSS: Main: 179126272 09:08:46 INFO - PROCESS | 13017 | 09:08:50 INFO - PROCESS | 13017 | Cycle 1(1): loaded http://localhost:37177/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37177/tests/kraken/driver.html?testName=imaging-darkroom) 09:08:50 INFO - PROCESS | 13017 | RSS: Main: 215265280 09:08:50 INFO - PROCESS | 13017 | 09:08:54 INFO - PROCESS | 13017 | Cycle 1(1): loaded http://localhost:37177/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37177/tests/kraken/driver.html?testName=imaging-desaturate) 09:08:54 INFO - PROCESS | 13017 | RSS: Main: 213778432 09:08:54 INFO - PROCESS | 13017 | 09:08:57 INFO - PROCESS | 13017 | Cycle 1(1): loaded http://localhost:37177/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37177/tests/kraken/driver.html?testName=json-parse-financial) 09:08:58 INFO - PROCESS | 13017 | RSS: Main: 213716992 09:08:58 INFO - PROCESS | 13017 | 09:09:00 INFO - PROCESS | 13017 | Cycle 1(1): loaded http://localhost:37177/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37177/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:09:00 INFO - PROCESS | 13017 | RSS: Main: 201617408 09:09:00 INFO - PROCESS | 13017 | 09:09:02 INFO - PROCESS | 13017 | Cycle 1(1): loaded http://localhost:37177/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37177/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:09:03 INFO - PROCESS | 13017 | RSS: Main: 205389824 09:09:03 INFO - PROCESS | 13017 | 09:09:05 INFO - PROCESS | 13017 | Cycle 1(1): loaded http://localhost:37177/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37177/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:09:06 INFO - PROCESS | 13017 | RSS: Main: 216457216 09:09:06 INFO - PROCESS | 13017 | 09:09:08 INFO - PROCESS | 13017 | Cycle 1(1): loaded http://localhost:37177/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37177/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:09:09 INFO - PROCESS | 13017 | RSS: Main: 225255424 09:09:09 INFO - PROCESS | 13017 | 09:09:12 INFO - PROCESS | 13017 | Cycle 1(1): loaded http://localhost:37177/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37177/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:09:13 INFO - PROCESS | 13017 | RSS: Main: 220004352 09:09:13 INFO - PROCESS | 13017 | 09:09:14 INFO - PROCESS | 13017 | Cycle 1(1): loaded http://localhost:37177/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37177/tests/kraken/driver.html?testName=ai-astar) 09:09:15 INFO - PROCESS | 13017 | RSS: Main: 283934720 09:09:15 INFO - PROCESS | 13017 | 09:09:15 INFO - PROCESS | 13017 | __start_tp_report 09:09:15 INFO - PROCESS | 13017 | _x_x_mozilla_page_load 09:09:15 INFO - PROCESS | 13017 | _x_x_mozilla_page_load_details 09:09:15 INFO - PROCESS | 13017 | |i|pagename|runs| 09:09:15 INFO - PROCESS | 13017 | |0;ai-astar;114;117;109;114;114;114;104;115;116;115 09:09:15 INFO - PROCESS | 13017 | |1;audio-beat-detection;160;133;159;181;133;157;159;137;198;138 09:09:15 INFO - PROCESS | 13017 | |2;audio-dft;160;161;163;160;160;162;160;161;161;160 09:09:15 INFO - PROCESS | 13017 | |3;audio-fft;75;74;110;113;74;73;74;126;115;74 09:09:15 INFO - PROCESS | 13017 | |4;audio-oscillator;95;95;143;94;94;93;144;98;94;146 09:09:15 INFO - PROCESS | 13017 | |5;imaging-gaussian-blur;117;116;117;117;117;117;118;118;117;117 09:09:15 INFO - PROCESS | 13017 | |6;imaging-darkroom;147;146;146;146;147;172;146;146;147;146 09:09:15 INFO - PROCESS | 13017 | |7;imaging-desaturate;94;94;95;95;95;95;94;95;94;95 09:09:15 INFO - PROCESS | 13017 | |8;json-parse-financial;66;67;67;67;68;66;66;87;65;68 09:09:15 INFO - PROCESS | 13017 | |9;json-stringify-tinderbox;65;65;65;65;65;65;65;65;65;65 09:09:15 INFO - PROCESS | 13017 | |10;stanford-crypto-aes;80;80;80;79;80;79;82;82;82;83 09:09:15 INFO - PROCESS | 13017 | |11;stanford-crypto-ccm;139;133;140;138;129;136;128;139;166;131 09:09:15 INFO - PROCESS | 13017 | |12;stanford-crypto-pbkdf2;186;185;190;193;182;181;186;181;180;185 09:09:15 INFO - PROCESS | 13017 | |13;stanford-crypto-sha256-iterative;75;76;75;74;74;82;73;75;73;73 09:09:15 INFO - PROCESS | 13017 | __end_tp_report 09:09:15 INFO - PROCESS | 13017 | __start_cc_report 09:09:15 INFO - PROCESS | 13017 | _x_x_mozilla_cycle_collect,1871 09:09:15 INFO - PROCESS | 13017 | __end_cc_report 09:09:15 INFO - PROCESS | 13017 | __startTimestamp1462464555146__endTimestamp 09:09:15 INFO - PROCESS | 13017 | 09:09:15 INFO - PROCESS | 13017 | ------- Summary: start ------- 09:09:15 INFO - PROCESS | 13017 | Number of tests: 14 09:09:15 INFO - PROCESS | 13017 | 09:09:15 INFO - PROCESS | 13017 | [#0] ai-astar Cycles:10 Average:113.20 Median:114.50 stddev:3.85 (3.4%) stddev-sans-first:4.08 09:09:15 INFO - PROCESS | 13017 | Values: 114.0 117.0 109.0 114.0 114.0 114.0 104.0 115.0 116.0 115.0 09:09:15 INFO - PROCESS | 13017 | 09:09:15 INFO - PROCESS | 13017 | [#1] audio-beat-detection Cycles:10 Average:155.50 Median:159.00 stddev:21.51 (13.5%) stddev-sans-first:22.75 09:09:15 INFO - PROCESS | 13017 | Values: 160.0 133.0 159.0 181.0 133.0 157.0 159.0 137.0 198.0 138.0 09:09:15 INFO - PROCESS | 13017 | 09:09:15 INFO - PROCESS | 13017 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.03 (0.6%) stddev-sans-first:1.05 09:09:15 INFO - PROCESS | 13017 | Values: 160.0 161.0 163.0 160.0 160.0 162.0 160.0 161.0 161.0 160.0 09:09:15 INFO - PROCESS | 13017 | 09:09:15 INFO - PROCESS | 13017 | [#3] audio-fft Cycles:10 Average:90.80 Median:74.00 stddev:22.06 (29.8%) stddev-sans-first:22.65 09:09:15 INFO - PROCESS | 13017 | Values: 75.0 74.0 110.0 113.0 74.0 73.0 74.0 126.0 115.0 74.0 09:09:15 INFO - PROCESS | 13017 | 09:09:15 INFO - PROCESS | 13017 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:94.00 stddev:24.01 (25.5%) stddev-sans-first:24.88 09:09:15 INFO - PROCESS | 13017 | Values: 95.0 95.0 143.0 94.0 94.0 93.0 144.0 98.0 94.0 146.0 09:09:15 INFO - PROCESS | 13017 | 09:09:15 INFO - PROCESS | 13017 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 09:09:15 INFO - PROCESS | 13017 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 118.0 118.0 117.0 117.0 09:09:15 INFO - PROCESS | 13017 | 09:09:15 INFO - PROCESS | 13017 | [#6] imaging-darkroom Cycles:10 Average:148.90 Median:146.50 stddev:8.13 (5.5%) stddev-sans-first:8.59 09:09:15 INFO - PROCESS | 13017 | Values: 147.0 146.0 146.0 146.0 147.0 172.0 146.0 146.0 147.0 146.0 09:09:15 INFO - PROCESS | 13017 | 09:09:15 INFO - PROCESS | 13017 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 09:09:15 INFO - PROCESS | 13017 | Values: 94.0 94.0 95.0 95.0 95.0 95.0 94.0 95.0 94.0 95.0 09:09:15 INFO - PROCESS | 13017 | 09:09:15 INFO - PROCESS | 13017 | [#8] json-parse-financial Cycles:10 Average:68.70 Median:67.00 stddev:6.50 (9.7%) stddev-sans-first:6.82 09:09:15 INFO - PROCESS | 13017 | Values: 66.0 67.0 67.0 67.0 68.0 66.0 66.0 87.0 65.0 68.0 09:09:15 INFO - PROCESS | 13017 | 09:09:15 INFO - PROCESS | 13017 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 09:09:15 INFO - PROCESS | 13017 | Values: 65.0 65.0 65.0 65.0 65.0 65.0 65.0 65.0 65.0 65.0 09:09:15 INFO - PROCESS | 13017 | 09:09:15 INFO - PROCESS | 13017 | [#10] stanford-crypto-aes Cycles:10 Average:80.70 Median:81.00 stddev:1.42 (1.8%) stddev-sans-first:1.48 09:09:15 INFO - PROCESS | 13017 | Values: 80.0 80.0 80.0 79.0 80.0 79.0 82.0 82.0 82.0 83.0 09:09:15 INFO - PROCESS | 13017 | 09:09:15 INFO - PROCESS | 13017 | [#11] stanford-crypto-ccm Cycles:10 Average:137.90 Median:138.50 stddev:10.80 (7.8%) stddev-sans-first:11.44 09:09:15 INFO - PROCESS | 13017 | Values: 139.0 133.0 140.0 138.0 129.0 136.0 128.0 139.0 166.0 131.0 09:09:15 INFO - PROCESS | 13017 | 09:09:15 INFO - PROCESS | 13017 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.90 Median:185.50 stddev:4.18 (2.3%) stddev-sans-first:4.41 09:09:15 INFO - PROCESS | 13017 | Values: 186.0 185.0 190.0 193.0 182.0 181.0 186.0 181.0 180.0 185.0 09:09:15 INFO - PROCESS | 13017 | 09:09:15 INFO - PROCESS | 13017 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.00 Median:75.00 stddev:2.67 (3.6%) stddev-sans-first:2.83 09:09:15 INFO - PROCESS | 13017 | Values: 75.0 76.0 75.0 74.0 74.0 82.0 73.0 75.0 73.0 73.0 09:09:15 INFO - PROCESS | 13017 | -------- Summary: end -------- 09:09:15 INFO - PROCESS | 13017 | 09:09:16 INFO - TEST-INFO | 13017: exit 0 09:09:16 INFO - TEST-OK | kraken | took 62921ms 09:09:16 INFO - SUITE-END | took 1180s 09:09:16 INFO - Completed test suite (00:19:40) 09:09:16 INFO - javascript benchmark 09:09:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2571.408576027514, 2651.5227259093353, 2661.880215390307, 2664.8934042638293, 2678.77230435413, 4530.841420550281, 4604.493505714373, 4608.976955115224, 4633.374494443249, 4654.162250794856, 4616.053708989657, 4700.576948074672, 4706.058788242357, 4734.7869345879435, 4763.54746299101, 4288.6140247377725, 4315.892102697434, 4358.673099517533, 4389.934150987738, 4470.798814053375, 4388.890277743066, 4427.424434823484, 4441.222786012451, 4442.289233722605, 4452.243118669818, 4194.4547208862805, 4250.192463431969, 4284.700070995032, 4299.333603291495, 4364.650827933758, 4310.418093557361, 4343.131373725268, 4345.283028300327, 4358.869233922956, 4399.186150562125, 4333.523312435629, 4348.673849461303, 4351.586599273064, 4353.717008394444, 4389.648828093745, 4361.869143925687, 4460.977695111536, 4522.5025247222775, 4597.517260687613, 4610.631149508032, 5021.723805190713, 5040.193569028937, 5063.392392912837, 5065.645404821664, 5114.156164232897, 5047.899042019139, 5077.086124497589, 5081.314022606938, 5083.059633967728, 5085.0, 4622.976885115587, 4711.764411779397, 4741.810327586858, 4787.8563643090765, 4791.448983366888, 5054.519820617035, 5055.949440505621, 5061.240813877947, 5062.696238225644, 5066.771995260222, 4792.496787837296, 4861.51384861511, 4863.513648635108, 4864.051509955525, 4916.164252077156, 4871.074495845849, 4902.0, 4911.533404326583, 4938.654294199371, 4941.357623508921, 4879.878003049952, 4906.515412189926, 4908.558229759339, 4912.72979986097, 4954.355933728664, 4804.711717296974, 4905.632077594195, 4905.852824415273, 4907.828226012072, 4962.5533701967, 4204.264253755642, 4230.280852255124, 4256.063665993476, 4286.464191976003, 4297.441332626801, 3672.6510981456718, 3681.7975011374633, 3683.3369993401443, 3688.483612294281, 3718.0, 4235.915281694349, 4319.157764236007, 4345.065810850682, 4345.456817897762, 4375.146846364992, 4967.552920237196, 4974.626902982291, 4976.42771081323, 4989.326440930428, 5029.924551131736, 4320.308750599952, 4320.503142138631, 4321.935170972438, 4338.58783415575, 4370.584794444522, 4343.131373725268, 4445.488768791565, 4448.688591798543, 4464.933026004613, 4542.6593005524055, 4728.1252968201, 4730.692504987233, 4732.100900828831, 4758.31004504338, 4767.523247675204, 4991.700497970133, 4995.375578052744, 4998.225275082368, 5016.372953380827, 5057.418396884405, 4587.357769912148, 4722.244440889442, 4743.288506723881, 4806.903861922672, 4810.903781924272, 4978.6763860348965, 4995.525425084611, 5017.598592112549, 5024.748762561931, 5073.695578265316, 5048.7223202722735, 5065.898682026413, 5078.7206703631655, 5088.363954505687, 5090.4073417809, 4702.506236845082, 4802.519748025309, 4838.612910967044, 4897.657163998629, 4954.232094025432, 4776.761161941959, 4790.8323208687525, 4791.520847915181, 4793.424789025339, 4838.540338667821, 4720.409948756405, 4731.905361892812, 4737.502562231054, 4751.287306903992, 4786.497417771084, 4677.789499472464, 4817.8313759018265, 4859.271109333628, 4906.362172917497, 4915.0415668944215, 4703.247480403119, 4712.69367491112, 4719.244920812654, 4720.197566413786, 4770.713757174581], "value": 4586.533485598326, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.6802592587039, 611.5199568338858, 613.9355367686393, 623.0840664223596, 631.807298773874, 27229.72770272297, 28038.158855234324, 28057.43885122299, 35415.0, 36363.272734545295, 35671.2865742685, 36329.27341453169, 36353.81823090887, 36401.81799091001, 36477.27045459089, 7449.813754656137, 7621.961890190541, 7622.961885190594, 7628.771136865875, 7629.618519074052, 7319.231480694503, 7629.0, 9412.388194767318, 9725.854112188323, 9742.074502922247, 9870.0, 9968.800623987516, 9981.351212171221, 9982.151517121054, 9985.20118390527, 9857.90142098577, 9974.750631234205, 9986.0, 9986.101250887383, 9992.551080093346, 9694.563744631509, 9857.753556161082, 9861.852072218922, 9870.2103831694, 9877.160441362494, 35930.8203458981, 36451.27097458063, 39712.404313935316, 39798.40302395437, 39869.0, 3166.208447888028, 3357.462805951036, 3451.534042904226, 3763.247350529905, 3778.8299526521373, 30359.24101897448, 30602.234944126354, 30653.620741035153, 30694.38611227763, 30927.536086958487, 3075.4310452566347, 3094.8452577371268, 3102.9379412411627, 3145.874165033396, 3202.9679703203137, 249590.0, 249995.9999999982, 250175.0, 250588.0, 251292.0, 52701.0, 54619.72690136603, 54650.72674636601, 54797.1780423294, 54882.45117548853, 51687.74156129195, 51748.48251517512, 51820.740896295276, 51822.22266666003, 51941.48058519366, 14906.403743850342, 15574.299156537983, 15611.765823512656, 15617.453389131326, 15620.375184992701, 10005.799884002425, 10410.375377477376, 11363.0, 11368.602098926498, 11379.37413442252, 15543.689126217638, 15620.218989050729, 15631.140287284308, 15648.295826687827, 15805.36778528869, 5895.67573783446, 6041.124037014608, 6100.481459076028, 6176.166217560662, 6188.257409110845, 943.1605870774879, 948.6679662118341, 985.4235272365603, 1006.5470538257667, 1085.636311835544, 27555.448891022068, 28642.856785716354, 28966.69649865761, 29390.559141612892, 29448.263793405335, 966.2801213096288, 1043.4678314059884, 1069.3476979042778, 1115.8549388579434, 1153.8557680289964, 15091.0, 15132.167730774912, 15469.922650386676, 15602.375904963674, 15738.449154279546, 347407.0, 351405.0, 353694.0, 355634.0, 355707.0, 51651.0, 52602.473975260524, 52655.47344526582, 52827.73586132045, 52833.47166528286, 1112.7663190729875, 1203.7351782607811, 1272.9172603780726, 1276.546825876819, 1287.7939529675393, 26138.73861261363, 28465.857670711513, 28779.712202877705, 28837.27906802347, 29205.123846284645, 40224.798876005436, 40630.59369406268, 40646.18707625772, 40667.0, 40683.3897491532, 198217.0, 201866.0, 201929.0, 202336.0, 202468.0, 27833.443331132858, 28601.0, 29425.11724648264, 29450.558241625964, 29464.852675736485, 37962.240755185296, 38240.80879595584, 38342.616573833904, 38360.80819595884, 39075.80462097671, 31849.68150318467, 32855.83572082124, 33076.83461582677, 33131.52724382274, 33884.152896177795, 32577.674223257465, 33856.83071584626, 36133.63866361303, 36208.275834482636, 36416.08959776027, 35281.294374112884, 35842.82078589591, 35956.0, 36062.4590631146, 36085.27829443344, 31530.684693152776, 32130.83934580312, 32295.35409291848, 32365.0, 32579.67420325861, 24825.1311204107, 24943.0, 25065.87467062653, 25421.237362879143, 25494.235172944842], "value": 17536.62272718867, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.09257781324817, 383.0978046700021, 383.60488696642454, 384.753757595139, 387.7072810028428, 15933.203339833006, 16289.674206515863, 17311.22099505522, 17326.82673173268, 17418.216180271887, 11284.830727539094, 15988.12065336406, 16712.331506739716, 16765.245563949622, 16765.413210537634, 3482.564679415073, 4566.337881007244, 4751.382320298357, 4759.405074365704, 4764.642651801111, 3585.8207089645543, 5206.687598744087, 5460.372057213432, 5469.07025805614, 5474.7810087596445, 5432.293801805779, 5437.429069947638, 5444.891102177954, 5453.945460545384, 5559.360673522536, 5881.4118588141055, 5898.8230353089475, 5914.8817023659285, 5921.171036054977, 5931.110333449974, 5159.58723302135, 5270.525652691238, 5283.07546179417, 5317.335333083364, 5432.103702889019, 12893.806592901114, 12945.741085178337, 12996.0, 13119.212847229197, 17279.395221167324, 1852.5183452302363, 2019.5859848730975, 2053.435305291042, 2071.730675012239, 2105.0632468551503, 8884.911150888473, 9132.543372831398, 9141.588628511667, 11600.361980091091, 13269.535566255136, 1648.0, 1684.3599432215801, 1701.3619892540298, 1728.4987353667548, 1774.370098614986, 66287.0, 69473.3052669472, 71604.6419767903, 72057.27942720558, 72200.2779972204, 10071.446070466194, 10198.541065652063, 10301.0, 10404.531796069195, 10464.319819211727, 14522.346494407777, 14549.34527946245, 14568.49010284635, 14610.0, 14622.634434139232, 6875.0, 7040.683169257396, 7223.566586004857, 7254.709811607582, 7276.054112965387, 6302.180716506825, 6430.164078669743, 6466.773662921869, 6597.670116494252, 6784.321567843176, 4184.623383895464, 4289.914201715948, 4306.483222013316, 4337.783110844445, 4419.580139886705, 1662.4347721774413, 1769.8938063716218, 1855.1559040636478, 1901.7923618502075, 1910.4650697804636, 397.48128692056565, 867.1935100356728, 884.8276034254638, 1026.7022563456514, 1041.8955906738881, 9929.304948653526, 16170.434034808724, 17415.303387864344, 17729.37947171843, 17914.91042544805, 864.6498168241872, 881.6825942660637, 904.6291020681489, 926.5552534783342, 952.4285428742837, 9369.672061477952, 9535.570899309549, 9828.21291639701, 10131.949340253399, 10195.082442580204, 292994.0, 307399.0, 308642.0, 309369.0, 416907.0, 74733.0, 78060.21939780643, 78808.0, 78984.0, 81885.0, 950.8763860698065, 952.2524818017823, 992.6327258914104, 993.9503024848729, 996.3523709588825, 15640.530784076496, 15879.52361429159, 15999.440019599258, 16086.034837909763, 16310.918445407697, 34130.0, 34832.30335393328, 35021.0, 35208.11979700528, 35727.106822329646, 47888.5211147898, 48869.0, 50361.244581330575, 50406.24390634217, 50479.747601261755, 7353.963230183815, 7473.88789168152, 7487.925120748723, 7536.660850261861, 7597.392208623186, 10103.797924041331, 10115.59537618487, 10738.946305268424, 10813.459327033774, 11415.60045398407, 9405.81188376215, 9511.143997040299, 9713.262185234717, 10298.794024119326, 10427.322224055411, 10061.547230374505, 10193.898061019296, 10200.80682653233, 10247.0, 10566.788664226826, 10143.28996970205, 10353.741156470847, 10366.429846358522, 10387.68836934893, 10478.685639430829, 7431.071116110486, 7716.8456630868195, 7738.729144479917, 7848.450608457353, 7973.20267973198, 9997.600095996078, 10343.94828025855, 10453.581856725647, 10515.26393152472, 10550.788984220426], "value": 8052.090371726868, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1307.6992291772885, 1486.7472529669958, 1498.6553092788658, 1655.3047719957617, 1810.415377552447, 7047.400970917472, 7342.3758980486655, 7347.0, 7355.521891077076, 7360.889586656191, 7035.718571257144, 7246.058012458373, 7288.817779555514, 7292.38014768744, 7306.634668266592, 1830.2130084063847, 2109.789021097893, 2166.166026079955, 2179.3570896585547, 2195.9560808783895, 2196.0447205465675, 2201.7798220177933, 2207.4040009197506, 2208.116753298685, 2209.4255493571627, 2122.7771084036185, 2194.58302922445, 2194.9903044599505, 2199.362184966366, 2201.2625770366867, 1798.8111248318935, 2107.7892210778955, 2148.44140523465, 2157.622416077196, 2158.4064382294837, 2080.552681173555, 2083.2396175396025, 2103.5267064910427, 2104.3581707579183, 2104.6737755647746, 7158.570485770871, 7249.492535522516, 7341.77974660761, 7342.265773422669, 7344.632768361561, 4314.223439780838, 4524.140413321491, 4528.773561321921, 4534.31985202219, 4543.0, 2769.9307517312027, 2831.8725657345467, 2891.927701807451, 2892.754115900151, 2908.9127326180246, 906.2206502407923, 919.5448253114685, 923.4044041593202, 937.2455173585261, 947.4788866123605, 10160.0, 10201.74495637615, 10204.97950204981, 10222.693319200436, 10235.692929212135, 4089.97955010229, 4160.875173744793, 4233.433629557022, 4278.507971583308, 4283.164782867311, 8787.077356877564, 8820.77948051291, 8832.77918052041, 8853.468791872509, 8871.556422178865, 3890.5525864525944, 4490.101979604092, 4507.887302817456, 4515.571020753023, 4517.887052823706, 3981.6217459341315, 4017.0, 4039.8788036358956, 4069.7965101744794, 4072.2466343726505, 3438.3123375324535, 3484.285721427152, 3533.1697051193464, 3535.840887160084, 3587.9103022424647, 1177.617274385828, 1186.0, 1191.4697959408154, 1195.109643315718, 1196.282230661596, 817.3338728935898, 818.893543839309, 826.7437094500724, 832.1871725993927, 846.2003406780533, 4907.337509436252, 5127.769250383742, 5138.203578445347, 5151.639385242997, 5293.761780719877, 934.9532523373804, 946.6071580294239, 978.2125389061873, 981.1709105805583, 992.6277645882794, 3423.863045478203, 3431.4852772084387, 3454.378211921878, 3497.0732755819727, 3512.0, 8848.1151884811, 9092.045335239836, 9208.677696280598, 9213.63145474187, 9237.030111838294, 8994.05562415937, 9008.954955225181, 9047.864282035775, 9076.41003334781, 9095.954520227357, 6915.723371065202, 7131.001659767637, 7167.641617919083, 7181.0, 7206.0, 4819.421669399554, 4980.477049909708, 5019.272205530105, 5037.722925239147, 5107.055194788976, 8256.298214651822, 8400.075991640793, 8454.704085356983, 8494.065652778067, 8504.574771261288, 8496.745097647081, 8521.91478085236, 8552.358573106918, 8553.31573474133, 8673.089325620971, 5325.920111198413, 5334.1732031535175, 5469.671819690831, 5802.535797136304, 5921.703914804329, 6974.0, 7114.0, 7126.429885609035, 7128.429725621834, 7131.572105673677, 6332.810015699536, 6581.80254592363, 6601.306862779531, 6648.83377915556, 6710.261871194262, 6463.385978332051, 6511.3163117871945, 6526.804195874131, 6552.508561857975, 6641.435477984425, 5906.852328691817, 6098.634081955097, 6098.695065246809, 6102.0541816018585, 6104.4200800923845, 4373.190959672471, 4434.3791869138995, 4445.955540444555, 4573.451185857718, 4594.310853372021, 4426.313921342197, 4464.709793863389, 4477.373167756582, 4552.385427967182, 4592.816287348469], "value": 4016.3812190075782, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.31696900756356, 315.25914101860633, 317.33043278681976, 317.8760283489438, 319.24657807574135, 4652.441706995161, 4736.608012953458, 4764.166270902596, 4765.428148622166, 4805.951940480594, 4699.577038066574, 4707.435107787071, 4713.646476514258, 4713.835015774449, 4738.763061846903, 3541.3271478419147, 3657.689096426807, 3669.431238158076, 3772.717046221531, 3782.186829831586, 3763.7553559018575, 3764.623537646241, 3780.508533890604, 3797.7721336719887, 3806.2301030021035, 3552.9111772205642, 3758.530183727034, 3773.283076215524, 3775.2260786538695, 3788.3938569828833, 3625.546806649169, 3783.2244389900006, 3789.7872680742175, 3793.981030094832, 3795.064517096287, 3375.3418083473734, 3376.2234686022107, 3377.240120972786, 3388.136025313554, 3395.779274347184, 4511.909761804745, 4522.773861306921, 4523.615492683126, 4529.932051019237, 4545.36364908913, 3941.408788681692, 4178.874633760992, 4184.246835569596, 4308.892277693051, 4322.654187664979, 4869.732164730938, 4873.415190177166, 4884.926726099111, 4906.0, 4909.852704418873, 3531.4349704047486, 3573.7319701022266, 3582.8566857325677, 3584.4981702561663, 3587.318409502186, 4962.354893863775, 5069.264956581312, 5144.43411224765, 5147.7683504242395, 5151.300070976568, 3631.9092022699115, 3643.6720695137033, 3650.9452358214116, 3658.762180458262, 3676.117731744416, 3688.4692852466465, 3693.9445908311395, 3697.815109244527, 3701.8704345348324, 3706.258748250307, 4155.667546596265, 4171.018766086085, 4183.602557757008, 4213.734355874222, 4219.45147130871, 4641.907161856744, 4935.777889994959, 4942.9752851236235, 4953.306537084811, 4989.725565093955, 1306.4578200046874, 1308.2739079810797, 1315.4606611289516, 1318.182726709427, 1320.0891384944357, 838.7064527415356, 871.3116637856023, 899.2446345070173, 921.893982192043, 930.3719989007393, 4637.8840528986375, 4645.233536466445, 4660.091282200006, 4664.137134630037, 4674.368960190399, 5305.143199880088, 5323.0, 5324.92012619811, 5334.0, 5352.839414817562, 4537.795799189044, 4596.540345965377, 4626.97686511572, 4636.629069674418, 4651.162790697707, 2838.758705510055, 2843.232327271625, 2850.629418175624, 2872.956905646417, 2874.3963767609034, 5057.974710126426, 5085.313482679865, 5092.719900405439, 5094.337736094284, 5109.156989096832, 5352.946470535323, 5485.588580856452, 5497.36780270274, 5510.0, 5515.365732940683, 5075.593952483792, 5076.18780995039, 5100.183970564692, 5111.923321150186, 5121.2574176744165, 5325.254464375068, 5369.1140961740875, 5391.487808658171, 5393.946060539344, 5399.163129714901, 5082.390113186441, 5255.185446255837, 5263.842084737464, 5268.762905669178, 5290.232916227203, 5045.7981680732355, 5065.924011139762, 5078.111330517218, 5078.873028174177, 5090.109230884655, 3831.2912111259507, 3839.4816699746293, 3842.5965273646984, 3842.9807850960565, 3858.6141385861188, 5232.895342093061, 5333.573314134937, 5358.705271210121, 5370.812021579226, 5373.919391209057, 5158.664686795346, 5186.144286192736, 5204.921926171186, 5205.245239440335, 5210.140326846028, 5107.41264754558, 5166.741662916915, 5173.042987047408, 5209.71346575942, 5218.269442278008, 4593.6554758392585, 5068.0, 5164.018836421068, 5164.9741751291, 5166.1254059455405, 4777.355057067391, 4939.950600494093, 4969.254611808257, 4984.426790918946, 5004.874878128076, 4853.689503834015, 4868.713618307557, 4882.267659851051, 4887.997960418177, 4889.266610008527], "value": 3844.478368354281, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [756.2210922749568, 786.9842603147936, 800.5396896784343, 804.5534728225836, 813.3899575318511, 11108.666739997803, 11326.377049262297, 11474.311541307527, 11495.310281383123, 11526.769464610703, 11570.942145289282, 11594.362310072942, 11621.418929053534, 11681.824772628417, 11707.356095414749, 662.3244290823382, 798.0662624729081, 828.6892415344261, 840.3865178419758, 849.600687676794, 835.3526017336552, 845.7970087179064, 846.5301757524571, 848.0925409811504, 850.2305413600701, 897.6499165325496, 899.703097977669, 899.9775005624846, 900.1268769293807, 900.7522931193942, 699.8215455058953, 860.5525126933959, 884.9955750221272, 886.6187539358074, 895.2882458445551, 650.5901282192236, 651.0787236060968, 653.1052458132389, 653.4282502810041, 653.4478365780908, 12238.938805306005, 12330.075244356709, 12332.630021099292, 12348.135630505778, 12353.75292494154, 11823.172377933548, 12508.624741257778, 12513.311767852765, 12756.107072504929, 13067.215967041913, 9467.763305917339, 9496.762580935463, 9544.188743956773, 9567.617295308179, 9723.0, 3328.7170590499836, 3418.435958066916, 3418.743594230418, 3455.6544345565494, 3534.452159915217, 40250.59749402498, 40359.7982010091, 40815.59184408148, 40899.591004089874, 40953.180936381104, 9689.079537443931, 10378.844317335246, 10492.21308401873, 10492.26554141218, 10559.366438013743, 18309.45071647853, 18322.633547329246, 18332.266709331478, 18337.541561460803, 18348.357807476943, 6745.258021617618, 6756.797296081126, 6802.217744959294, 6812.6934287957165, 6860.451163906875, 3746.5316835395574, 3828.559715632738, 3833.9808300958875, 3887.2419878123496, 3990.10222699896, 2936.295289130636, 2995.8052726572705, 3006.0, 3008.7743419243643, 3020.7281344678645, 476.0431532619391, 493.8518444466646, 509.4319833385748, 513.6070905757099, 533.4665334665335, 574.4973148495067, 581.528961541153, 588.2294194605081, 612.9785457508966, 618.6690120785358, 7757.146713861471, 7776.455648104691, 7789.961050194826, 8090.555019473985, 8139.348852091818, 599.4544964082664, 599.4994179859866, 600.1118344849647, 633.9873202535923, 634.2294112653057, 3442.9827850860584, 3707.94438083429, 3767.2088861339425, 3805.334066538345, 3820.0, 52641.7367913158, 53981.1902821458, 54109.729451353276, 54376.0, 54584.72707636436, 45516.544834551896, 46383.30425043627, 46694.76652616715, 47763.522364775905, 48703.26945095755, 42914.57085429106, 43467.565324346986, 43625.78187109044, 44041.559584403745, 44081.0, 7365.8526829462035, 7511.586862722603, 7580.689108518534, 7626.122995855548, 7663.693452261847, 26448.20655380342, 27140.0, 27788.583171252852, 27797.44405111927, 28570.0, 35810.82094589614, 36068.27863442664, 36116.0, 36708.26583468262, 37026.62973370232, 10751.19366047534, 10759.569617215224, 11141.16441266892, 11145.164112691418, 11292.266002709797, 9331.503988986888, 11958.64124076279, 11985.880141198826, 12547.3098979557, 12626.810597840857, 10514.474276286002, 11592.0, 11599.103018610858, 11609.709757255798, 11668.358240296526, 11420.30364292241, 11478.0, 11669.649910502698, 11750.70623234426, 11897.643070707893, 11451.0, 11610.88389116098, 11648.126390520576, 11996.160268781101, 12140.33228172459, 8898.4660920345, 9009.306184464338, 9275.907240927505, 9303.953480232827, 9454.101860323259, 9378.437293762123, 9599.184069354184, 9731.172850307803, 9833.508324583885, 9848.518789544369], "value": 5972.775297104849, "unit": "score"}], "name": "dromaeo_css", "value": 6252.298218557721, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 117.0, 109.0, 114.0, 114.0, 114.0, 104.0, 115.0, 116.0, 115.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 133.0, 159.0, 181.0, 133.0, 157.0, 159.0, 137.0, 198.0, 138.0], "value": 155.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 163.0, 160.0, 160.0, 162.0, 160.0, 161.0, 161.0, 160.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 110.0, 113.0, 74.0, 73.0, 74.0, 126.0, 115.0, 74.0], "value": 90.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 143.0, 94.0, 94.0, 93.0, 144.0, 98.0, 94.0, 146.0], "value": 109.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 147.0, 172.0, 146.0, 146.0, 147.0, 146.0], "value": 148.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 67.0, 68.0, 66.0, 66.0, 87.0, 65.0, 68.0], "value": 68.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 80.0, 79.0, 80.0, 79.0, 82.0, 82.0, 82.0, 83.0], "value": 80.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 133.0, 140.0, 138.0, 129.0, 136.0, 128.0, 139.0, 166.0, 131.0], "value": 137.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 185.0, 190.0, 193.0, 182.0, 181.0, 186.0, 181.0, 180.0, 185.0], "value": 184.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 74.0, 74.0, 82.0, 73.0, 75.0, 73.0, 73.0], "value": 75.0, "unit": "score"}], "name": "kraken", "value": 1602.7000000000003, "alertThreshold": 2.0}]} 09:09:16 INFO - Return code: 0 09:09:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:09:16 ERROR - # TBPL SUCCESS # 09:09:16 INFO - Running post-action listener: _resource_record_post_action 09:09:16 INFO - Running post-run listener: _resource_record_post_run 09:09:17 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 520445952; Read time: 12; Write time: 373852 09:09:17 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 234700800; Read time: 0; Write time: 176644 09:09:17 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283189248; Read time: 12; Write time: 197116 09:09:17 INFO - Running post-run listener: _upload_blobber_files 09:09:17 INFO - Blob upload gear active. 09:09:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:09:17 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 09:09:17 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:09:17 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:09:17 INFO - (blobuploader) - INFO - Open directory for files ... 09:09:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:09:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:09:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:09:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:09:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:09:18 INFO - (blobuploader) - INFO - Done attempting. 09:09:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:09:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:09:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:09:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:09:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:09:19 INFO - (blobuploader) - INFO - Done attempting. 09:09:19 INFO - (blobuploader) - INFO - Iteration through files over. 09:09:19 INFO - Return code: 0 09:09:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:09:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:09:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0e33dd9c423488ce841420e72f05c1f990b36fd5fa5f7c28cff8745eab79c1d4749513fe54dd63c9b179a94d24d13f8dd487b264ac18cdcc11ca4c29b87386b9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bab3b7c47ba84f2c5054a9cc70300c74a1223e13d3cd76770baf0d2509b327df63279fc6ca106510e23e92565ba2fd875b41cb615a26db2f96cff42af44a6ff4"} 09:09:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:09:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:09:19 INFO - Contents: 09:09:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0e33dd9c423488ce841420e72f05c1f990b36fd5fa5f7c28cff8745eab79c1d4749513fe54dd63c9b179a94d24d13f8dd487b264ac18cdcc11ca4c29b87386b9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bab3b7c47ba84f2c5054a9cc70300c74a1223e13d3cd76770baf0d2509b327df63279fc6ca106510e23e92565ba2fd875b41cb615a26db2f96cff42af44a6ff4"} 09:09:19 INFO - Running post-run listener: copy_logs_to_upload_dir 09:09:19 INFO - Copying logs to upload dir... 09:09:19 INFO - mkdir: /builds/slave/test/build/upload/logs 09:09:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.880935 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-05-05 09:09:19.515527) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-05 09:09:19.519241) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1462461527.641334-183314310 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-Non-PGO/sha512/0e33dd9c423488ce841420e72f05c1f990b36fd5fa5f7c28cff8745eab79c1d4749513fe54dd63c9b179a94d24d13f8dd487b264ac18cdcc11ca4c29b87386b9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bab3b7c47ba84f2c5054a9cc70300c74a1223e13d3cd76770baf0d2509b327df63279fc6ca106510e23e92565ba2fd875b41cb615a26db2f96cff42af44a6ff4"} build_url:https://queue.taskcluster.net/v1/task/NdBx6tzkT4OwufcQJGduGA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011402 build_url: 'https://queue.taskcluster.net/v1/task/NdBx6tzkT4OwufcQJGduGA/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-Non-PGO/sha512/0e33dd9c423488ce841420e72f05c1f990b36fd5fa5f7c28cff8745eab79c1d4749513fe54dd63c9b179a94d24d13f8dd487b264ac18cdcc11ca4c29b87386b9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bab3b7c47ba84f2c5054a9cc70300c74a1223e13d3cd76770baf0d2509b327df63279fc6ca106510e23e92565ba2fd875b41cb615a26db2f96cff42af44a6ff4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-05 09:09:19.547340) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 09:09:19.547659) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1462461527.641334-183314310 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004686 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 09:09:19.598493) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-05 09:09:19.598816) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-05 09:09:19.599100) ========= ========= Total master_lag: 0.48 =========