builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-019 starttime: 1461303160.87 results: success (0) buildid: 20160421210502 builduid: 4af037259fc74061b246381ccbe2bf02 revision: 2271b0c11307e6b780eb61d2c6dbae6ae9ed927f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 22:32:40.873909) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 22:32:40.874342) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 22:32:40.874615) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 22:32:40.988873) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 22:32:40.989211) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1461294358.679176-739690502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-21 22:32:41-- 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% 215M=0s 2016-04-21 22:32:41 (215 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.074563 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 22:32:41.081580) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 22:32:41.081864) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1461294358.679176-739690502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017892 ========= master_lag: 0.12 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 22:32:41.214857) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-21 22:32:41.215175) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2271b0c11307e6b780eb61d2c6dbae6ae9ed927f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 2271b0c11307e6b780eb61d2c6dbae6ae9ed927f --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=78329bfc0fd5309db0a6e0ac000001b4-1461294358.679176-739690502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-21 22:32:41,475 truncating revision to first 12 chars 2016-04-21 22:32:41,475 Setting DEBUG logging. 2016-04-21 22:32:41,475 attempt 1/10 2016-04-21 22:32:41,475 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2271b0c11307?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-21 22:32:42,879 unpacking tar archive at: fx-team-2271b0c11307/testing/mozharness/ program finished with exit code 0 elapsedTime=1.700675 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-21 22:32:42.942381) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 22:32:42.942914) ========= script_repo_revision: 2271b0c11307e6b780eb61d2c6dbae6ae9ed927f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 22:32:42.943334) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 22:32:42.943599) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 22:32:42.954826) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-04-21 22:32:42.955425) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1461294358.679176-739690502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:32:43 INFO - MultiFileLogger online at 20160421 22:32:43 in /builds/slave/test 22:32:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 22:32:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:32:43 INFO - {'append_to_log': False, 22:32:43 INFO - 'base_work_dir': '/builds/slave/test', 22:32:43 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 22:32:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:32:43 INFO - 'branch': 'Fx-Team-Non-PGO', 22:32:43 INFO - 'buildbot_json_path': 'buildprops.json', 22:32:43 INFO - 'config_files': ('talos/linux_config.py',), 22:32:43 INFO - 'default_actions': ('clobber', 22:32:43 INFO - 'read-buildbot-config', 22:32:43 INFO - 'download-and-extract', 22:32:43 INFO - 'populate-webroot', 22:32:43 INFO - 'create-virtualenv', 22:32:43 INFO - 'install', 22:32:43 INFO - 'run-tests'), 22:32:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:32:43 INFO - 'download_minidump_stackwalk': True, 22:32:43 INFO - 'download_symbols': 'ondemand', 22:32:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:32:43 INFO - 'tooltool.py': '/tools/tooltool.py', 22:32:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:32:43 INFO - '/tools/misc-python/virtualenv.py')}, 22:32:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:32:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:32:43 INFO - 'installer_path': 'installer.exe', 22:32:43 INFO - 'log_level': 'info', 22:32:43 INFO - 'log_name': 'talos', 22:32:43 INFO - 'log_to_console': True, 22:32:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:32:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:32:43 INFO - 'opt_config_files': (), 22:32:43 INFO - 'pip_index': False, 22:32:43 INFO - 'sps_profile': False, 22:32:43 INFO - 'sps_profile_interval': 0, 22:32:43 INFO - 'suite': 'dromaeojs', 22:32:43 INFO - 'system_bits': '32', 22:32:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:32:43 INFO - 'title': 'talos-linux64-ix-019', 22:32:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:32:43 INFO - 'use_talos_json': True, 22:32:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:32:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:32:43 INFO - 'work_dir': 'build'} 22:32:43 INFO - ##### 22:32:43 INFO - ##### Running clobber step. 22:32:43 INFO - ##### 22:32:43 INFO - Running pre-action listener: _resource_record_pre_action 22:32:43 INFO - Running main action method: clobber 22:32:43 INFO - rmtree: /builds/slave/test/build 22:32:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:32:43 INFO - Running post-action listener: _resource_record_post_action 22:32:43 INFO - ##### 22:32:43 INFO - ##### Running read-buildbot-config step. 22:32:43 INFO - ##### 22:32:43 INFO - Running pre-action listener: _resource_record_pre_action 22:32:43 INFO - Running main action method: read_buildbot_config 22:32:43 INFO - Using buildbot properties: 22:32:43 INFO - { 22:32:43 INFO - "project": "", 22:32:43 INFO - "product": "firefox", 22:32:43 INFO - "script_repo_revision": "production", 22:32:43 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 22:32:43 INFO - "repository": "", 22:32:43 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 22:32:43 INFO - "buildid": "20160421210502", 22:32:43 INFO - "pgo_build": "False", 22:32:43 INFO - "basedir": "/builds/slave/test", 22:32:43 INFO - "buildnumber": 1700, 22:32:43 INFO - "slavename": "talos-linux64-ix-019", 22:32:43 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:32:43 INFO - "platform": "ubuntu64_hw", 22:32:43 INFO - "scheduler": "tests-fx-team-linux64-talos", 22:32:43 INFO - "branch": "fx-team", 22:32:43 INFO - "repo_path": "integration/fx-team", 22:32:43 INFO - "revision": "2271b0c11307e6b780eb61d2c6dbae6ae9ed927f", 22:32:43 INFO - "stage_platform": "linux64", 22:32:43 INFO - "builduid": "4af037259fc74061b246381ccbe2bf02", 22:32:43 INFO - "slavebuilddir": "test" 22:32:43 INFO - } 22:32:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 22:32:43 INFO - Running post-action listener: _resource_record_post_action 22:32:43 INFO - ##### 22:32:43 INFO - ##### Running download-and-extract step. 22:32:43 INFO - ##### 22:32:43 INFO - Running pre-action listener: _resource_record_pre_action 22:32:43 INFO - Running main action method: download_and_extract 22:32:43 INFO - mkdir: /builds/slave/test/build/tests 22:32: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')]} 22:32:43 INFO - https://queue.taskcluster.net/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:32:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:32:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:32:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:32:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:32:44 INFO - Downloaded 1361 bytes. 22:32:44 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:32:44 INFO - Using the following test package requirements: 22:32:44 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:32:44 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:32:44 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:32:44 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:32:44 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:32:44 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:32:44 INFO - u'jsshell-linux-x86_64.zip'], 22:32:44 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:32:44 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:32:44 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:32:44 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:32:44 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:32:44 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:32:44 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:32:44 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:32:44 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:32:44 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:32:44 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:32:44 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:32:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:32:44 INFO - https://queue.taskcluster.net/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:32:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:32:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:32:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:32:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:32:46 INFO - Downloaded 22281373 bytes. 22:32:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:32:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:32:47 INFO - Return code: 0 22:32:47 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:32:47 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')]} 22:32:47 INFO - https://queue.taskcluster.net/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:32:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:32:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:32:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:32:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:32:51 INFO - Downloaded 22281373 bytes. 22:32:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:32:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:32:52 INFO - Return code: 0 22:32:52 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')]} 22:32:52 INFO - https://queue.taskcluster.net/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:32:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:32:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:32:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:32:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:32:54 INFO - Downloaded 10845952 bytes. 22:32:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:32:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 22:32:55 INFO - Return code: 0 22:32:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:32:55 INFO - https://queue.taskcluster.net/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:32:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:32:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:32:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:32:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:32:56 INFO - Downloaded 54630132 bytes. 22:32:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:32:56 INFO - mkdir: /builds/slave/test/properties 22:32:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:32:56 INFO - Writing to file /builds/slave/test/properties/build_url 22:32:56 INFO - Contents: 22:32:56 INFO - build_url:https://queue.taskcluster.net/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:32:57 INFO - Running post-action listener: _resource_record_post_action 22:32:57 INFO - Running post-action listener: set_extra_try_arguments 22:32:57 INFO - ##### 22:32:57 INFO - ##### Running populate-webroot step. 22:32:57 INFO - ##### 22:32:57 INFO - Running pre-action listener: _resource_record_pre_action 22:32:57 INFO - Running main action method: populate_webroot 22:32:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:32:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:32:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:32:57 INFO - '--tppagecycles', 22:32:57 INFO - '7'], 22:32:57 INFO - 'tests': ['tsvgm']}}, 22:32:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:32:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:32:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:32:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:32:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:32:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:32:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:32:57 INFO - 'talos_options': ['--disable-e10s'], 22:32:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:32:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:32:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:32:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:32:57 INFO - 'talos_options': ['--disable-e10s'], 22:32:57 INFO - 'tests': ['damp', 'tps']}, 22:32:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:32:57 INFO - 'tests': ['damp', 'tps']}, 22:32:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:32:57 INFO - 'tests': ['dromaeo_dom']}, 22:32:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:32:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:32:57 INFO - 'tests': ['a11yr', 22:32:57 INFO - 'ts_paint', 22:32:57 INFO - 'tpaint', 22:32:57 INFO - 'sessionrestore', 22:32:57 INFO - 'sessionrestore_no_auto_restore', 22:32:57 INFO - 'tabpaint']}, 22:32:57 INFO - 'other-e10s': {'tests': ['a11yr', 22:32:57 INFO - 'ts_paint', 22:32:57 INFO - 'tpaint', 22:32:57 INFO - 'sessionrestore', 22:32:57 INFO - 'sessionrestore_no_auto_restore', 22:32:57 INFO - 'tabpaint']}, 22:32:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:32:57 INFO - 'ts_paint', 22:32:57 INFO - 'tpaint', 22:32:57 INFO - 'sessionrestore', 22:32:57 INFO - 'sessionrestore_no_auto_restore', 22:32:57 INFO - 'tabpaint']}, 22:32:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:32:57 INFO - 'ts_paint', 22:32:57 INFO - 'tpaint', 22:32:57 INFO - 'sessionrestore', 22:32:57 INFO - 'sessionrestore_no_auto_restore', 22:32:57 INFO - 'tabpaint']}, 22:32:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:32:57 INFO - 'tests': ['a11yr', 22:32:57 INFO - 'ts_paint', 22:32:57 INFO - 'tpaint', 22:32:57 INFO - 'sessionrestore', 22:32:57 INFO - 'sessionrestore_no_auto_restore', 22:32:57 INFO - 'tabpaint']}, 22:32:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:32:57 INFO - 'tests': ['a11yr', 22:32:57 INFO - 'ts_paint', 22:32:57 INFO - 'tpaint', 22:32:57 INFO - 'sessionrestore', 22:32:57 INFO - 'sessionrestore_no_auto_restore', 22:32:57 INFO - 'tabpaint']}, 22:32:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:32:57 INFO - 'tests': ['tsvgx', 22:32:57 INFO - 'tsvgr_opacity', 22:32:57 INFO - 'tart', 22:32:57 INFO - 'tscrollx', 22:32:57 INFO - 'cart']}, 22:32:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:32:57 INFO - 'tsvgr_opacity', 22:32:57 INFO - 'tart', 22:32:57 INFO - 'tscrollx', 22:32:57 INFO - 'cart']}, 22:32:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:32:57 INFO - 'talos_options': ['--disable-e10s'], 22:32:57 INFO - 'tests': ['tp5o']}, 22:32:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:32:57 INFO - 'tests': ['tp5o']}, 22:32:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:32:57 INFO - 'talos_options': ['--disable-e10s', 22:32:57 INFO - '--xperf_path', 22:32:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:32:57 INFO - 'tests': ['tp5n']}, 22:32:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:32:57 INFO - 'talos_options': ['--xperf_path', 22:32:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:32:57 INFO - 'tests': ['tp5n']}}, 22:32:57 INFO - 'talos.zip': {'path': '', 22:32:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:32:57 INFO - Running post-action listener: _resource_record_post_action 22:32:57 INFO - ##### 22:32:57 INFO - ##### Running create-virtualenv step. 22:32:57 INFO - ##### 22:32:57 INFO - Running pre-action listener: _resource_record_pre_action 22:32:57 INFO - Running main action method: create_virtualenv 22:32:57 INFO - Creating virtualenv /builds/slave/test/build/venv 22:32:57 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 22:32:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:32:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:32:57 INFO - Using real prefix '/usr' 22:32:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:32:57 INFO - Installing distribute.............................................................................................................................................................................................done. 22:32:59 INFO - Installing pip.................done. 22:32:59 INFO - Return code: 0 22:32:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:32:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:32:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:32:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:32:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:32:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:32:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:32:59 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 0x7fcf64b68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a57410>, '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 0x1a58310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a587a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1461294358.679176-739690502', '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 22:32:59 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 22:32:59 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 22:32:59 INFO - Using env: {'DISPLAY': ':0', 22:32:59 INFO - 'HOME': '/home/cltbld', 22:32:59 INFO - 'LANG': 'en_US.UTF-8', 22:32:59 INFO - 'LANGUAGE': 'en_US:en', 22:32:59 INFO - 'LOGNAME': 'cltbld', 22:32:59 INFO - 'MAIL': '/var/mail/cltbld', 22:32:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:32:59 INFO - 'MOZ_NO_REMOTE': '1', 22:32:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:32:59 INFO - 'NO_EM_RESTART': '1', 22:32:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:32:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:32:59 INFO - 'PWD': '/builds/slave/test', 22:32:59 INFO - 'SHELL': '/bin/bash', 22:32:59 INFO - 'SHLVL': '1', 22:32:59 INFO - 'TERM': 'linux', 22:32:59 INFO - 'TMOUT': '86400', 22:32:59 INFO - 'USER': 'cltbld', 22:32:59 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1461294358.679176-739690502', 22:32:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:32:59 INFO - '_': '/tools/buildbot/bin/python'} 22:32:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:32:59 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 22:32:59 INFO - Cleaning up... 22:32:59 INFO - Return code: 0 22:32:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:32:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:32:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:32:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:32:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:32:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:32:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:32:59 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 0x7fcf64b68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a57410>, '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 0x1a58310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a587a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1461294358.679176-739690502', '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 22:32:59 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 22:32:59 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 22:32:59 INFO - Using env: {'DISPLAY': ':0', 22:32:59 INFO - 'HOME': '/home/cltbld', 22:32:59 INFO - 'LANG': 'en_US.UTF-8', 22:32:59 INFO - 'LANGUAGE': 'en_US:en', 22:32:59 INFO - 'LOGNAME': 'cltbld', 22:32:59 INFO - 'MAIL': '/var/mail/cltbld', 22:32:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:32:59 INFO - 'MOZ_NO_REMOTE': '1', 22:32:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:32:59 INFO - 'NO_EM_RESTART': '1', 22:32:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:32:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:32:59 INFO - 'PWD': '/builds/slave/test', 22:32:59 INFO - 'SHELL': '/bin/bash', 22:32:59 INFO - 'SHLVL': '1', 22:32:59 INFO - 'TERM': 'linux', 22:32:59 INFO - 'TMOUT': '86400', 22:32:59 INFO - 'USER': 'cltbld', 22:32:59 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1461294358.679176-739690502', 22:32:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:32:59 INFO - '_': '/tools/buildbot/bin/python'} 22:33:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:33:00 INFO - Downloading/unpacking psutil>=0.7.1 22:33: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 22:33: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 22:33: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 22:33: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 22:33: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 22:33: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 22:33:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:33:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:33:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:33:02 INFO - Installing collected packages: psutil 22:33:02 INFO - Running setup.py install for psutil 22:33:02 INFO - building 'psutil._psutil_linux' extension 22:33:02 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 22:33:02 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 22:33:02 INFO - building 'psutil._psutil_posix' extension 22:33:02 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 22:33:02 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 22:33:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:33:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:33:02 INFO - Successfully installed psutil 22:33:02 INFO - Cleaning up... 22:33:02 INFO - Return code: 0 22:33:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:33: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')]} 22:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:33:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33: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')]} 22:33:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:33:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33: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', '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 0x7fcf64b68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a57410>, '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 0x1a58310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a587a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1461294358.679176-739690502', '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 22:33: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 22:33: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 mozsystemmonitor==0.0.0 22:33:02 INFO - Using env: {'DISPLAY': ':0', 22:33:02 INFO - 'HOME': '/home/cltbld', 22:33:02 INFO - 'LANG': 'en_US.UTF-8', 22:33:02 INFO - 'LANGUAGE': 'en_US:en', 22:33:02 INFO - 'LOGNAME': 'cltbld', 22:33:02 INFO - 'MAIL': '/var/mail/cltbld', 22:33:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:33:02 INFO - 'MOZ_NO_REMOTE': '1', 22:33:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:33:02 INFO - 'NO_EM_RESTART': '1', 22:33:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:33:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:33:02 INFO - 'PWD': '/builds/slave/test', 22:33:02 INFO - 'SHELL': '/bin/bash', 22:33:02 INFO - 'SHLVL': '1', 22:33:02 INFO - 'TERM': 'linux', 22:33:02 INFO - 'TMOUT': '86400', 22:33:02 INFO - 'USER': 'cltbld', 22:33:02 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1461294358.679176-739690502', 22:33:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:33:02 INFO - '_': '/tools/buildbot/bin/python'} 22:33:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:33:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:33: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 22:33: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 22:33: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 22:33: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 22:33: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 22:33: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 22:33:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:33:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:33:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:33:04 INFO - Installing collected packages: mozsystemmonitor 22:33:04 INFO - Running setup.py install for mozsystemmonitor 22:33:04 INFO - Successfully installed mozsystemmonitor 22:33:04 INFO - Cleaning up... 22:33:04 INFO - Return code: 0 22:33:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:33:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:33:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:33:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:33:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:04 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 0x7fcf64b68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a57410>, '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 0x1a58310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a587a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1461294358.679176-739690502', '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 22:33:04 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 22:33:04 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 22:33:04 INFO - Using env: {'DISPLAY': ':0', 22:33:04 INFO - 'HOME': '/home/cltbld', 22:33:04 INFO - 'LANG': 'en_US.UTF-8', 22:33:04 INFO - 'LANGUAGE': 'en_US:en', 22:33:04 INFO - 'LOGNAME': 'cltbld', 22:33:04 INFO - 'MAIL': '/var/mail/cltbld', 22:33:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:33:04 INFO - 'MOZ_NO_REMOTE': '1', 22:33:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:33:04 INFO - 'NO_EM_RESTART': '1', 22:33:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:33:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:33:04 INFO - 'PWD': '/builds/slave/test', 22:33:04 INFO - 'SHELL': '/bin/bash', 22:33:04 INFO - 'SHLVL': '1', 22:33:04 INFO - 'TERM': 'linux', 22:33:04 INFO - 'TMOUT': '86400', 22:33:04 INFO - 'USER': 'cltbld', 22:33:04 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1461294358.679176-739690502', 22:33:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:33:04 INFO - '_': '/tools/buildbot/bin/python'} 22:33:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:33:05 INFO - Downloading/unpacking blobuploader==1.2.4 22:33:05 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 22:33:05 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 22:33:05 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 22:33:05 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 22:33:05 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 22:33:05 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 22:33:07 INFO - Downloading blobuploader-1.2.4.tar.gz 22:33:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:33:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:33:07 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 22:33:07 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 22:33:07 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 22:33:07 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 22:33:07 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 22:33:07 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 22:33:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:33:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:33:07 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 22:33:07 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 22:33:07 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 22:33:07 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 22:33:07 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 22:33:07 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 22:33:07 INFO - Downloading docopt-0.6.1.tar.gz 22:33:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:33:07 INFO - Installing collected packages: blobuploader, requests, docopt 22:33:07 INFO - Running setup.py install for blobuploader 22:33:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:33:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:33:07 INFO - Running setup.py install for requests 22:33:08 INFO - Running setup.py install for docopt 22:33:08 INFO - Successfully installed blobuploader requests docopt 22:33:08 INFO - Cleaning up... 22:33:08 INFO - Return code: 0 22:33:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:33:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:33:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:33:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:33:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:08 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 0x7fcf64b68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a57410>, '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 0x1a58310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a587a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1461294358.679176-739690502', '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 22:33:08 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 22:33:08 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 22:33:08 INFO - Using env: {'DISPLAY': ':0', 22:33:08 INFO - 'HOME': '/home/cltbld', 22:33:08 INFO - 'LANG': 'en_US.UTF-8', 22:33:08 INFO - 'LANGUAGE': 'en_US:en', 22:33:08 INFO - 'LOGNAME': 'cltbld', 22:33:08 INFO - 'MAIL': '/var/mail/cltbld', 22:33:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:33:08 INFO - 'MOZ_NO_REMOTE': '1', 22:33:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:33:08 INFO - 'NO_EM_RESTART': '1', 22:33:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:33:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:33:08 INFO - 'PWD': '/builds/slave/test', 22:33:08 INFO - 'SHELL': '/bin/bash', 22:33:08 INFO - 'SHLVL': '1', 22:33:08 INFO - 'TERM': 'linux', 22:33:08 INFO - 'TMOUT': '86400', 22:33:08 INFO - 'USER': 'cltbld', 22:33:08 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1461294358.679176-739690502', 22:33:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:33:08 INFO - '_': '/tools/buildbot/bin/python'} 22:33:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:33:08 INFO - Running setup.py (path:/tmp/pip-yvGi0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:33:08 INFO - Running setup.py (path:/tmp/pip-kaOsAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:33:08 INFO - Running setup.py (path:/tmp/pip-zoN_6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:33:08 INFO - Running setup.py (path:/tmp/pip-5PpT4I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:33:08 INFO - Running setup.py (path:/tmp/pip-BzzLBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:33:08 INFO - Running setup.py (path:/tmp/pip-BRfZFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:33:09 INFO - Running setup.py (path:/tmp/pip-ssnazN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:33:09 INFO - Running setup.py (path:/tmp/pip-Ibqml3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:33:09 INFO - Running setup.py (path:/tmp/pip-Xr9k_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:33:09 INFO - Running setup.py (path:/tmp/pip-KJQ50z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:33:09 INFO - Running setup.py (path:/tmp/pip-XuHGgO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:33:09 INFO - Running setup.py (path:/tmp/pip-NMhxW7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:33:09 INFO - Running setup.py (path:/tmp/pip-9KAeFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:33:09 INFO - Running setup.py (path:/tmp/pip-wca3dZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:33:09 INFO - Running setup.py (path:/tmp/pip-OEkIvG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:33:09 INFO - Running setup.py (path:/tmp/pip-NNzdEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:33:09 INFO - Running setup.py (path:/tmp/pip-dhwFJ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:33:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:33:09 INFO - Running setup.py install for manifestparser 22:33:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:33:09 INFO - Running setup.py install for mozcrash 22:33:09 INFO - Running setup.py install for mozdebug 22:33:10 INFO - Running setup.py install for mozdevice 22:33:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:33:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:33:10 INFO - Running setup.py install for mozfile 22:33:10 INFO - Running setup.py install for mozhttpd 22:33:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:33:10 INFO - Running setup.py install for mozinfo 22:33:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:33:10 INFO - Running setup.py install for mozInstall 22:33:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:33:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:33:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:33:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:33:10 INFO - Running setup.py install for mozleak 22:33:10 INFO - Running setup.py install for mozlog 22:33:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:33:10 INFO - Running setup.py install for moznetwork 22:33:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:33:10 INFO - Running setup.py install for mozprocess 22:33:11 INFO - Running setup.py install for mozprofile 22:33:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:33:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:33:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:33:11 INFO - Running setup.py install for mozrunner 22:33:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:33:11 INFO - Running setup.py install for mozscreenshot 22:33:11 INFO - Running setup.py install for moztest 22:33:11 INFO - Running setup.py install for mozversion 22:33:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:33:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:33:11 INFO - Cleaning up... 22:33:11 INFO - Return code: 0 22:33:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:33:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:33:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:33:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:33:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:11 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 0x7fcf64b68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a57410>, '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 0x1a58310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a587a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1461294358.679176-739690502', '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 22:33:11 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 22:33:11 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 22:33:11 INFO - Using env: {'DISPLAY': ':0', 22:33:11 INFO - 'HOME': '/home/cltbld', 22:33:11 INFO - 'LANG': 'en_US.UTF-8', 22:33:11 INFO - 'LANGUAGE': 'en_US:en', 22:33:11 INFO - 'LOGNAME': 'cltbld', 22:33:11 INFO - 'MAIL': '/var/mail/cltbld', 22:33:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:33:11 INFO - 'MOZ_NO_REMOTE': '1', 22:33:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:33:11 INFO - 'NO_EM_RESTART': '1', 22:33:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:33:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:33:11 INFO - 'PWD': '/builds/slave/test', 22:33:11 INFO - 'SHELL': '/bin/bash', 22:33:11 INFO - 'SHLVL': '1', 22:33:11 INFO - 'TERM': 'linux', 22:33:11 INFO - 'TMOUT': '86400', 22:33:11 INFO - 'USER': 'cltbld', 22:33:11 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1461294358.679176-739690502', 22:33:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:33:11 INFO - '_': '/tools/buildbot/bin/python'} 22:33:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:33:11 INFO - Running setup.py (path:/tmp/pip-4Vum5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:33:11 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)) 22:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:33:11 INFO - Running setup.py (path:/tmp/pip-qJ5gtu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:33:11 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)) 22:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:33:11 INFO - Running setup.py (path:/tmp/pip-_tiq_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:33:12 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)) 22:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:33:12 INFO - Running setup.py (path:/tmp/pip-VzcxEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:33:12 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)) 22:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:33:12 INFO - Running setup.py (path:/tmp/pip-CrIJpD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:33:12 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)) 22:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:33:12 INFO - Running setup.py (path:/tmp/pip-hil3bA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:33:12 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)) 22:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:33:12 INFO - Running setup.py (path:/tmp/pip-TBnqjT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:33:12 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)) 22:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:33:12 INFO - Running setup.py (path:/tmp/pip-Y76oT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:33:12 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)) 22:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:33:12 INFO - Running setup.py (path:/tmp/pip-tlEsjL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:33:12 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)) 22:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:33:12 INFO - Running setup.py (path:/tmp/pip-M7GSPY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:33:12 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)) 22:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:33:12 INFO - Running setup.py (path:/tmp/pip-RCq5gc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:33:12 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)) 22:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:33:12 INFO - Running setup.py (path:/tmp/pip-SCWuWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:33:12 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)) 22:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:33:12 INFO - Running setup.py (path:/tmp/pip-4MFwoM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:33:12 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)) 22:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:33:12 INFO - Running setup.py (path:/tmp/pip-7SOWQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:33:12 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)) 22:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:33:12 INFO - Running setup.py (path:/tmp/pip-LUkpvo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:33:12 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)) 22:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:33:12 INFO - Running setup.py (path:/tmp/pip-eAhLAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:33:12 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)) 22:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:33:12 INFO - Running setup.py (path:/tmp/pip-S8cQ0y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:33:13 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)) 22:33:13 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)) 22:33:13 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)) 22:33:13 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)) 22:33:13 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)) 22:33:13 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)) 22:33:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:33: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 22:33: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 22:33: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 22:33: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 22:33: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 22:33: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 22:33:14 INFO - Downloading blessings-1.6.tar.gz 22:33:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:33:14 INFO - Installing collected packages: blessings 22:33:14 INFO - Running setup.py install for blessings 22:33:15 INFO - Successfully installed blessings 22:33:15 INFO - Cleaning up... 22:33:15 INFO - Return code: 0 22:33:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:33:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:33:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:33:15 INFO - Reading from file tmpfile_stdout 22:33:15 INFO - Current package versions: 22:33:15 INFO - argparse == 1.2.1 22:33:15 INFO - blessings == 1.6 22:33:15 INFO - blobuploader == 1.2.4 22:33:15 INFO - docopt == 0.6.1 22:33:15 INFO - manifestparser == 1.1 22:33:15 INFO - mozInstall == 1.12 22:33:15 INFO - mozcrash == 0.17 22:33:15 INFO - mozdebug == 0.1 22:33:15 INFO - mozdevice == 0.48 22:33:15 INFO - mozfile == 1.2 22:33:15 INFO - mozhttpd == 0.7 22:33:15 INFO - mozinfo == 0.9 22:33:15 INFO - mozleak == 0.1 22:33:15 INFO - mozlog == 3.1 22:33:15 INFO - moznetwork == 0.27 22:33:15 INFO - mozprocess == 0.22 22:33:15 INFO - mozprofile == 0.28 22:33:15 INFO - mozrunner == 6.11 22:33:15 INFO - mozscreenshot == 0.1 22:33:15 INFO - mozsystemmonitor == 0.0 22:33:15 INFO - moztest == 0.7 22:33:15 INFO - mozversion == 1.4 22:33:15 INFO - psutil == 3.1.1 22:33:15 INFO - requests == 1.2.3 22:33:15 INFO - wsgiref == 0.1.2 22:33:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:33: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')]} 22:33:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:33:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33: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')]} 22:33:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:33:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:15 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 0x7fcf64b68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a57410>, '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 0x1a58310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a587a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1461294358.679176-739690502', '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 22:33:15 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 22:33:15 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 22:33:15 INFO - Using env: {'DISPLAY': ':0', 22:33:15 INFO - 'HOME': '/home/cltbld', 22:33:15 INFO - 'LANG': 'en_US.UTF-8', 22:33:15 INFO - 'LANGUAGE': 'en_US:en', 22:33:15 INFO - 'LOGNAME': 'cltbld', 22:33:15 INFO - 'MAIL': '/var/mail/cltbld', 22:33:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:33:15 INFO - 'MOZ_NO_REMOTE': '1', 22:33:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:33:15 INFO - 'NO_EM_RESTART': '1', 22:33:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:33:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:33:15 INFO - 'PWD': '/builds/slave/test', 22:33:15 INFO - 'SHELL': '/bin/bash', 22:33:15 INFO - 'SHLVL': '1', 22:33:15 INFO - 'TERM': 'linux', 22:33:15 INFO - 'TMOUT': '86400', 22:33:15 INFO - 'USER': 'cltbld', 22:33:15 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1461294358.679176-739690502', 22:33:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:33:15 INFO - '_': '/tools/buildbot/bin/python'} 22:33:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:33:15 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)) 22:33:15 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)) 22:33:15 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)) 22:33:15 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)) 22:33:15 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)) 22:33:15 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)) 22:33:15 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)) 22:33:15 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)) 22:33:15 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)) 22:33:15 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)) 22:33:15 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)) 22:33:15 INFO - Cleaning up... 22:33:15 INFO - Return code: 0 22:33:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:33: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')]} 22:33:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:33:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33: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')]} 22:33:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:33:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf64b68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a57410>, '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 0x1a58310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a587a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1461294358.679176-739690502', '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 22:33: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', 'jsonschema'] in /builds/slave/test/build 22:33: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 jsonschema 22:33:15 INFO - Using env: {'DISPLAY': ':0', 22:33:15 INFO - 'HOME': '/home/cltbld', 22:33:15 INFO - 'LANG': 'en_US.UTF-8', 22:33:15 INFO - 'LANGUAGE': 'en_US:en', 22:33:15 INFO - 'LOGNAME': 'cltbld', 22:33:15 INFO - 'MAIL': '/var/mail/cltbld', 22:33:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:33:15 INFO - 'MOZ_NO_REMOTE': '1', 22:33:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:33:15 INFO - 'NO_EM_RESTART': '1', 22:33:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:33:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:33:15 INFO - 'PWD': '/builds/slave/test', 22:33:15 INFO - 'SHELL': '/bin/bash', 22:33:15 INFO - 'SHLVL': '1', 22:33:15 INFO - 'TERM': 'linux', 22:33:15 INFO - 'TMOUT': '86400', 22:33:15 INFO - 'USER': 'cltbld', 22:33:15 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1461294358.679176-739690502', 22:33:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:33:15 INFO - '_': '/tools/buildbot/bin/python'} 22:33:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:33:15 INFO - Downloading/unpacking jsonschema 22:33: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 22:33: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 22:33: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 22:33: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 22:33: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 22:33: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 22:33:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:33:17 INFO - Downloading/unpacking functools32 (from jsonschema) 22:33: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 22:33: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 22:33: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 22:33: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 22:33: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 22:33: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 22:33:17 INFO - Downloading functools32-3.2.3-2.tar.gz 22:33:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:33:17 INFO - warning: no files found matching '*.txt' 22:33:17 INFO - no previously-included directories found matching 'build' 22:33:17 INFO - no previously-included directories found matching 'dist' 22:33:17 INFO - no previously-included directories found matching '.git*' 22:33:17 INFO - Installing collected packages: jsonschema, functools32 22:33:17 INFO - Running setup.py install for functools32 22:33:18 INFO - warning: no files found matching '*.txt' 22:33:18 INFO - no previously-included directories found matching 'build' 22:33:18 INFO - no previously-included directories found matching 'dist' 22:33:18 INFO - no previously-included directories found matching '.git*' 22:33:18 INFO - Successfully installed jsonschema functools32 22:33:18 INFO - Cleaning up... 22:33:18 INFO - Return code: 0 22:33:18 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:33:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:33:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:33:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:33:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:33:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:33:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcf64b68f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19c85a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a57410>, '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 0x1a58310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a587a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1461294358.679176-739690502', '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 22:33:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 22:33:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 22:33:18 INFO - Using env: {'DISPLAY': ':0', 22:33:18 INFO - 'HOME': '/home/cltbld', 22:33:18 INFO - 'LANG': 'en_US.UTF-8', 22:33:18 INFO - 'LANGUAGE': 'en_US:en', 22:33:18 INFO - 'LOGNAME': 'cltbld', 22:33:18 INFO - 'MAIL': '/var/mail/cltbld', 22:33:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:33:18 INFO - 'MOZ_NO_REMOTE': '1', 22:33:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:33:18 INFO - 'NO_EM_RESTART': '1', 22:33:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:33:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:33:18 INFO - 'PWD': '/builds/slave/test', 22:33:18 INFO - 'SHELL': '/bin/bash', 22:33:18 INFO - 'SHLVL': '1', 22:33:18 INFO - 'TERM': 'linux', 22:33:18 INFO - 'TMOUT': '86400', 22:33:18 INFO - 'USER': 'cltbld', 22:33:18 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1461294358.679176-739690502', 22:33:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:33:18 INFO - '_': '/tools/buildbot/bin/python'} 22:33:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:33:18 INFO - Downloading/unpacking flake8 22:33: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 22:33: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 22:33: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 22:33: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 22:33: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 22:33: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 22:33:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:33:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:33:20 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 22:33:20 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 22:33:20 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 22:33:20 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 22:33:20 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 22:33:20 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 22:33:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:33:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:33:20 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 22:33:20 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 22:33:20 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 22:33:20 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 22:33:20 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 22:33:20 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 22:33:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:33:20 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 22:33:20 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 22:33:20 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 22:33:20 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 22:33:20 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 22:33:20 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 22:33:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:33:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:33:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:33:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:33:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:33:20 INFO - no previously-included directories found matching 'docs/_build' 22:33:20 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:33:21 INFO - Running setup.py install for pep8 22:33:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:33:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:33:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:33:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:33:21 INFO - no previously-included directories found matching 'docs/_build' 22:33:21 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:33:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:33:21 INFO - Cleaning up... 22:33:21 INFO - Return code: 0 22:33:21 INFO - Running post-action listener: _resource_record_post_action 22:33:21 INFO - Running post-action listener: _start_resource_monitoring 22:33:21 INFO - Starting resource monitoring. 22:33:21 INFO - ##### 22:33:21 INFO - ##### Running install step. 22:33:21 INFO - ##### 22:33:21 INFO - Running pre-action listener: _resource_record_pre_action 22:33:21 INFO - Running main action method: install 22:33:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:33:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:33:21 INFO - Reading from file tmpfile_stdout 22:33:21 INFO - Detecting whether we're running mozinstall >=1.0... 22:33:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:33:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:33:21 INFO - Reading from file tmpfile_stdout 22:33:21 INFO - Output received: 22:33:21 INFO - Usage: mozinstall [options] installer 22:33:21 INFO - Options: 22:33:21 INFO - -h, --help show this help message and exit 22:33:21 INFO - -d DEST, --destination=DEST 22:33:21 INFO - Directory to install application into. [default: 22:33:21 INFO - "/builds/slave/test"] 22:33:21 INFO - --app=APP Application being installed. [default: firefox] 22:33:21 INFO - mkdir: /builds/slave/test/build/application 22:33:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:33:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:33:37 INFO - Reading from file tmpfile_stdout 22:33:37 INFO - Output received: 22:33:37 INFO - /builds/slave/test/build/application/firefox/firefox 22:33:37 INFO - Running post-action listener: _resource_record_post_action 22:33:37 INFO - ##### 22:33:37 INFO - ##### Running run-tests step. 22:33:37 INFO - ##### 22:33:37 INFO - Running pre-action listener: _resource_record_pre_action 22:33:37 INFO - Running main action method: run_tests 22:33:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:33:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:33:37 INFO - Python 2.7.3 22:33:37 INFO - Return code: 0 22:33:37 INFO - grabbing minidump binary from tooltool 22:33:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:33:37 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 0x1a57410>, '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 0x1a58310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a587a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:33:37 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 22:33:37 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 22:33:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:33:37 INFO - Return code: 0 22:33:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:33:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:33:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:33:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:33:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:33:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:33:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:33:38 INFO - Return code: 0 22:33:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 22:33:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --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 22:33:38 INFO - Using env: {'DISPLAY': ':0', 22:33:38 INFO - 'HOME': '/home/cltbld', 22:33:38 INFO - 'LANG': 'en_US.UTF-8', 22:33:38 INFO - 'LANGUAGE': 'en_US:en', 22:33:38 INFO - 'LOGNAME': 'cltbld', 22:33:38 INFO - 'MAIL': '/var/mail/cltbld', 22:33:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:33:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:33:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:33:38 INFO - 'MOZ_NO_REMOTE': '1', 22:33:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:33:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:33:38 INFO - 'NO_EM_RESTART': '1', 22:33:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:33:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:33:38 INFO - 'PWD': '/builds/slave/test', 22:33:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:33:38 INFO - 'SHELL': '/bin/bash', 22:33:38 INFO - 'SHLVL': '1', 22:33:38 INFO - 'TERM': 'linux', 22:33:38 INFO - 'TMOUT': '86400', 22:33:38 INFO - 'USER': 'cltbld', 22:33:38 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1461294358.679176-739690502', 22:33:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:33:38 INFO - '_': '/tools/buildbot/bin/python'} 22:33:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 22:33:38 INFO - mozversion application_buildid: 20160421210502 22:33:38 INFO - mozversion application_changeset: 2271b0c11307e6b780eb61d2c6dbae6ae9ed927f 22:33:38 INFO - mozversion application_display_name: Nightly 22:33:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:33:38 INFO - mozversion application_name: Firefox 22:33:38 INFO - mozversion application_remotingname: firefox 22:33:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:33:38 INFO - mozversion application_vendor: Mozilla 22:33:38 INFO - mozversion application_version: 48.0a1 22:33:38 INFO - mozversion platform_buildid: 20160421210502 22:33:38 INFO - mozversion platform_changeset: 2271b0c11307e6b780eb61d2c6dbae6ae9ed927f 22:33:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:33:38 INFO - mozversion platform_version: 48.0a1 22:33:38 INFO - using testdate: 1461303218 22:33:38 INFO - actual date: 1461303218 22:33:38 INFO - starting webserver on 'localhost:49900' 22:33:38 INFO - SUITE-START | Running 2 tests 22:33:38 INFO - TEST-START | dromaeo_css 22:33:38 INFO - operating with platform_type : linux_ 22:33:38 INFO - Initialising browser for dromaeo_css test... 22:33:38 INFO - TEST-INFO | started process 19899 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_HQsKG/profile http://localhost:49900/getInfo.html) 22:33:43 INFO - PROCESS | 19899 | __metrics Screen width/height:1600/1200 22:33:43 INFO - PROCESS | 19899 | colorDepth:24 22:33:43 INFO - PROCESS | 19899 | Browser inner width/height: 1024/697 22:33:43 INFO - PROCESS | 19899 | __metrics 22:33:44 ERROR - PROCESS | 19899 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:33:45 INFO - TEST-INFO | 19899: exit 0 22:33:45 INFO - Browser initialized. 22:33:45 INFO - Running cycle 1/1 for dromaeo_css test... 22:33:45 INFO - TEST-INFO | started process 19979 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_HQsKG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:33:57 INFO - PROCESS | 19979 | RSS: Main: 155230208 22:33:57 INFO - PROCESS | 19979 | 22:34:48 INFO - PROCESS | 19979 | 1461303288251 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] 22:37:00 INFO - PROCESS | 19979 | Cycle 1(1): loaded http://localhost:49900/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49900/tests/dromaeo/cssquery-ext.html) 22:37:01 INFO - PROCESS | 19979 | RSS: Main: 238280704 22:37:01 INFO - PROCESS | 19979 | 22:40:03 INFO - PROCESS | 19979 | Cycle 1(1): loaded http://localhost:49900/tests/dromaeo/cssquery-ext.html (next: http://localhost:49900/tests/dromaeo/cssquery-jquery.html) 22:40:04 INFO - PROCESS | 19979 | RSS: Main: 233340928 22:40:04 INFO - PROCESS | 19979 | 22:43:06 INFO - PROCESS | 19979 | Cycle 1(1): loaded http://localhost:49900/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49900/tests/dromaeo/cssquery-mootools.html) 22:43:07 INFO - PROCESS | 19979 | RSS: Main: 241844224 22:43:07 INFO - PROCESS | 19979 | 22:46:09 INFO - PROCESS | 19979 | Cycle 1(1): loaded http://localhost:49900/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49900/tests/dromaeo/cssquery-prototype.html) 22:46:09 INFO - PROCESS | 19979 | RSS: Main: 225673216 22:46:09 INFO - PROCESS | 19979 | 22:49:12 INFO - PROCESS | 19979 | Cycle 1(1): loaded http://localhost:49900/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49900/tests/dromaeo/cssquery-yui.html) 22:49:13 INFO - PROCESS | 19979 | RSS: Main: 222392320 22:49:13 INFO - PROCESS | 19979 | 22:52:16 INFO - PROCESS | 19979 | Cycle 1(1): loaded http://localhost:49900/tests/dromaeo/cssquery-yui.html (next: http://localhost:49900/tests/dromaeo/cssquery-dojo.html) 22:52:16 INFO - PROCESS | 19979 | RSS: Main: 264323072 22:52:16 INFO - PROCESS | 19979 | 22:52:16 INFO - PROCESS | 19979 | __start_tp_report 22:52:16 INFO - PROCESS | 19979 | _x_x_mozilla_page_load 22:52:16 INFO - PROCESS | 19979 | _x_x_mozilla_page_load_details 22:52:16 INFO - PROCESS | 19979 | |i|pagename|runs| 22:52:16 INFO - PROCESS | 19979 | |0;dojo.html;2605.882735276912;2690.9327266818314;2697.2043247242063;2711.9864400677993;2729.508688436082;4597.057603191346;4639.164950308943;4714.222153344698;4714.90570188596;4742.596879265267;4650.069986002796;4697.131030759312;4721.079389519045;4739.526047395268;4768.451628062774;4293.227219100569;4330.198913201052;4374.912501749963;4406.801693923781;4451.666125040619;4357.520672725997;4367.213901497729;4418.867433976986;4440.045390241097;4445.644348452132;4233.5131459881895;4314.633256173198;4343.869683909487;4407.691461597689;4412.294032954728;4292.656587473026;4292.763897985609;4300.182965236626;4304.117655880537;4308.4399028126145;4261.083866968616;4277.893052673677;4288.721233119837;4296.57034296571;4303.074838909618;4619;4649.465311489154;4667.696599721007;4670.532946705336;4736.4316282046375;5039.77321020555;5059.494050594911;5065.290859279704;5065.645404821664;5068.670536415121;4868.9269660955115;5025.422076461217;5073.3911930568565;5078.5937125029905;5109;4694.882627934329;4704.5765881070865;4706.270528068155;4731.101090792738;4752.263399173134;5134.255532947702;5155.5617772489;5156.432792392834;5158.071547121479;5166.354205724285;4838;4878.365812444359;4919.114559379274;4953.628477864175;4961.479044700327;5040.949590504048;5083.288339632454;5099.158638824627;5109.054824857413;5144.254083157921;4834.226523756252;5017.1721665924715;5027;5031.597472202215;5039.521245481674;4895.510448955147;4922.458529561745;4981.37732783402;5040.143175660147;5096.184610462308;4216.30430978885;4219.683523735732;4220.198162349144;4220.662347012231;4266.189424009428;3702.629737026276;3711.721620878445;3726.795026273581;3731.272401881607;3743.4010558311084;4226.704130710882;4232.30167022444;4312.417823593837;4348.9565104349185;4349.913001740011;4961.801527938842;4977.104121258136;4984.27727979441;5001.349824522788;5031.597472202215;4221.894452638647;4267.509236437787;4277.165952639268;4298.075913678512;4315.611594956469;4490.259107247333;4494.865154045384;4496.348029535699;4530.456345238526;4541.750203738826;4762.59517940972;4782.067496838223;4782.306565547907;4785.880352991203;4816.903661926742;4882;5010.073136469765;5091.109055915126;5094.133997220555;5143.948560514347;4674.836380726658;4694.06118776253;4695.389599352063;4708.741019243975;4743.478217396153;4895.6083513318135;4900.8774780630765;4905.926411103765;4912.042151780369;4967.205247160581;4931.087748766489;4978.502149784992;5019.799208031784;5047.899042019212;5143.202803565453;4835.734034627989;4838.830640927551;4857.489963553776;4904.5340692634145;4908.705477671351;4846.273059041172;4873.074115917964;4880.487548807324;4891.119598472167;4922.975385123052;4667.229907065432;4745.691530050535;4815.566599006106;4874.512548745239;4918.458969513279;4871.951280487291;4909.239067944474;4945.085159245551;4951.10880041596;4964.35463389757;4824.204006338915;4850.927236091532;4852.0164706931555;4854.490278520704;4895.853124406273 22:52:16 INFO - PROCESS | 19979 | |1;ext.html;586.1822757253632;595.1756816808721;598.9670568118758;608.5192697768764;647.2588885725844;27569.724302756968;34086;34815.30369392611;34836.129096772594;34841.12897177565;36215.4567681485;36909;36931.81534092333;37001.62998370016;37035.81482092586;7226.927730722704;7493.4005279577505;7672.309492145706;7683;9377.0154133816;9541.475218862959;9694.903050969506;9695.418274903494;9699.757506062335;9701.563429645683;9668.516574171299;9763.755906102333;9769.218462522982;9770.511474426286;9771.071748183947;9615;9621.615135394575;9649.469279189641;9661.13049825519;9699.90300096997;9622.230221582327;9966.950165249127;9993.750156246078;9997.550110244983;9998.55006524701;36361.09097272563;36835;36868.07829804276;36873.63126368729;36908.446373304425;2911.243076800026;3043.923901902448;3185.2992341684794;3231.6929891660257;3294.3246634439884;28502.857485712648;28683.426331473253;28688.585478910638;28751.28121796951;29314.560281595794;3469.3755124077657;3473.565804274466;3503.2993401319836;3504.9649503505148;3576.928461430783;241466;242107;243469;243627;243641;49576;49606;49940;50036.499635003915;50038.49961500411;53969.95225358114;54094.18858717122;57590;59542;59564.404355955885;12889.226646401246;13037.413316400594;13039.282839443922;13044.086913916124;13045.412956416983;8885.955570222237;9210.76973075665;10305.175585953106;10631.043206111488;10658.73353166177;17659.55851103707;17672.646547068987;17691.73462398065;17765.378211762527;17843.821561784214;6686.966565167143;6699.9665001674675;6891.241963384024;6979;6990.650467476606;888.5024386343669;966.6278482784179;985.4530735441755;1033.534909290807;1041.234692501011;27704.584431233547;28030.719692803217;28132.85933570319;28325.150245492667;30396.088117356514;936.817320622472;957.8371676814958;982.2731178927543;1005.0954141272913;1094.682542062793;13787.276590426196;14389.928050359891;14464.927675361767;14794.482193123189;14827.481038163829;345333;345947;352829;353212;354198;47397.763011184725;48297.75851120722;48321;48333;48366.75816620894;1084.5228099636136;1165.8484397028333;1218.2081646929566;1234.2286071205317;1256.1520973342956;25673.229803105936;27265.31836704098;27438.725612743616;27665.861670691516;27860.16419507418;40531;40743.1851362977;41643.16713665771;41643.7917810409;41689.1662166761;268105;268695;271262;271443;271543.49597763986;22393.32820015402;24772.38069048288;25392;25455.236342909742;25496;35759.46360804538;35802.64197357993;36012.60874544967;36320.63679363278;36729.63270367369;30120.698793012667;30556.84721576378;30680.693193067782;30995.225119372197;31260.218494536908;30895.536566951963;31822.36355272928;32007.359852803278;32179.51730723994;33792.83103584466;33017.834910825295;33040.50439243461;33250.315648751595;33551;33807;28816.58777915475;29979.250518737204;30032.249193769458;30257;30288.84855575708;23109.632094656863;23488.64767028462;23813.404664883517;24018.51962960696;24070.759292406852 22:52:16 INFO - PROCESS | 19979 | |2;jquery.html;375.7013174526251;377.1420019455736;377.2285675793003;378.48148037189054;384.2027792330914;15895;16497.917510412448;17208.913955430206;17258.568535786595;17296.654066918654;15753.60615984601;16091.678166436664;16823.242954067067;16946.745798813026;16949.91525042373;4997.700137991723;5153.2270159476;5179.482051794809;5185.688858668492;5187.507186817265;3686.7972261525606;3875.476810630571;5069.569086627623;5546.805861794838;5862.794802181925;5756.366799652035;5797.246357973458;5824.388439213885;5825;5827.1550625159325;5533.6956467394275;5848.093545500455;5872.765089396419;5919.437653422897;5924.2298501195;3377.9662203377898;4909.3126962225315;5139.743012849342;5165.63840531163;5170.715610641413;19324.613507729766;19471.4158575243;19495.512612184666;20980;21025.68461473079;1917.1851962915844;1927.8554108441922;1953.540917884296;2091.383042002613;2171.7176767020346;12842.871571284355;12884;12997.805032924514;13020.283884386356;13500.594982150551;1775.4052392448416;1798.7931387890428;1810.900400477973;1867.9533011674816;1891.300218918995;65662.3433765661;67320.66339668319;67875.66062169657;68116.3188368115;69036.65481672609;9314.254859611216;9395.765105872408;9698.563564639608;9720.902790971999;9966.950165249273;13110.868891311156;13374.799378009338;13395.330233488286;13397.53108641193;13420.261885596386;6752.493562982698;6755.662216889136;6845.520813543004;7207.243239459886;7340.4861659684375;6841;6896.3103689631635;6933.237343892168;7006.159260888726;7019.684114214872;6091.482224011009;6112.816615501542;6116.510679145657;6166.321704612489;6263.96868015657;1632.4531282020419;1728.1186594836724;1728.260706779743;1770.663573920951;1782.5543614096475;792.9960350198328;851.9105493923173;883.6774577279375;884.8053428245776;1029.5367084811865;16929.661406771796;18242.361517346828;18407.171677274553;18520.907395462935;18868.15093320804;863.2834747159842;885.2210055151554;886.4548302793736;913.7532866126242;989.3717489394287;9907.455089969977;10363.740906477247;10387.94806025965;10400.895991040145;10405;374836;407509;407869;410089;413351;51576.74211628918;76812;80793;80962.19037809546;82116.58941705253;876.2770714160715;955.302629080761;971.223021582731;993.2749093161888;993.7018894331671;13688.452461901412;15963.920180399024;16657.91671041637;16820.915895420443;16958.236879340213;33801.3239735199;34262.657373425944;34605.48091778575;34710.65289347175;35234.8238258807;42661;42995.140097198506;44377.33433998557;44476.777616111714;45280.77359613313;7556.8488630228185;7708.922910771045;7760.92239077602;7829.373650108091;8096.230858068474;12083.879161208628;12171.513139474322;12215.877841221474;12289;12568.120231584067;10528.36829790215;10574.98814071343;10580.100691441006;10765.46172691378;11160.49777760019;10630.149588032784;10694.572217111228;10874.891251087387;10959.671209863716;11277.210595258253;10601.575936962436;10858.945705271422;10994;11156;11229.38238396896;7675.769726908202;7819.452638315263;7978.680852765824;8011.198880111942;8069.3544516439715;10865.402402867918;11012;11173.664790056311;11204.551817927191;11231.55073797039 22:52:16 INFO - PROCESS | 19979 | |3;mootools.html;1299.4737131461761;1379.5585412667945;1415.8159439272897;1487.6057844671163;1739.1130523433046;7486.663100160492;7751.883721744179;7812.687492500293;7815.882761758571;7825.765227043191;7579.810504737385;7796.961015194916;7810.453268271223;7811.140774514813;7814.023247094114;1983.4743792894894;2056.794320567946;2058.6294466995937;2245.8091062259687;2294.506681063571;2237.641977283635;2291.873946932918;2296.2651951375565;2298.586254474194;2298.908043678259;2200.9449763755874;2215.1582398688556;2216.8004879560835;2220.367195349326;2290.1183044527893;2009.1461129020108;2211.8894055297333;2318.4435735423463;2321.8258630602686;2326.31373744744;2327.895244713975;2341.4263505441277;2347.0963678983544;2352.9058837646476;2353.011735071274;7690.423218258597;7746.728864489716;7764.145943946161;7764.767056988299;7767.8446431071625;4590.288505281686;4735.076660051292;4743.051389722069;4743.928841067387;4747.074320507502;2852.8003039787222;2935.222166125978;2981.910542683723;2985.805922615045;3012.0963710886867;912.5847739278612;943.1605870775015;948.6063283737241;948.7628092976756;950.2065775077818;10707.196960228013;10911.345319280868;10938.070264027567;10968.725781855437;10984.560617575367;4415.337699345059;4579.450465944108;4593.586577208067;4595.218812801765;4623.688155922039;8395.496270223806;8422.915770842335;8455.704050358208;8462.323014158852;8463.788405289793;4700.529947005341;4707.482176960531;4715.339852420664;4723.173444647242;4727.385439892861;4328.956710432855;4368.191884501377;4445.222086134913;4493.0115374617535;4535.9773201133785;3398.9972957977457;3417.6069751978343;3477.165480284764;3494.930101397958;3515.8945231643092;1020.2348238820884;1025.6153942271649;1032.26193271811;1038.3769738157046;1045.8849526552226;733.2630706140295;767.1484652036236;775.5540564175622;792.2750683124876;812.0417906869832;5130.820421285312;5132.727490135131;5198.2722418861385;5281.762320695578;5312.681239125587;396.6648182285964;404.6904118349465;414.5398607545622;416.9833206671699;419.46727655877476;3336.115929278743;3370.1069216657606;3465.878694245689;3483.4600636901323;3518.9296214075575;9470.715878523655;9738.95130524357;9914.256430767577;9945.45300008492;9973.252006099572;9834.75413114678;9860.605575777032;9868.851967220497;9882.851757223647;9908.306418550776;7037.7184912602925;7416.7774966751085;7458.440616953641;7464.477486575887;7573.015507983927;5087.491250874883;5117.820876269313;5155.9742201288755;5215.869603259949;5232.398274198364;8724.69463568772;8871.778205544913;8949.686760963335;8972.461652300883;8989.280857531512;6787.321267873173;8939.910600893907;9076;9081.137291957253;9189.770255743393;6604.14146160996;6658.067870498037;6684.498662600227;6700.6984685688285;6710.899336510054;7146.642667866482;7303.415726741954;7325.7802265932105;7356.154042284991;7363.042804435389;6448.484121270381;6517.087607735016;6518.934810651833;6531.444827189742;6700.329967003261;6508.9349106508325;6566.868662626625;6594.373534514213;6669.833254168685;6699.497537684596;6172.660503672341;6244.2819075806865;6252.749890004349;6354.586951848115;6405.775797847053;4262.339337402707;4263.637590804692;4379.4525684289465;4390.560943905584;4450.087732014865;4570.588647021784;4570.931436028529;4616.746078965689;4639.536046395334;4702.811887524461 22:52:16 INFO - PROCESS | 19979 | |4;prototype.html;307.8568465663466;317.89350567559865;320.47762147699245;321.81656455820183;323.40977715668896;4911.582515486179;5098.2097774844915;5116.846494605164;5126.692398456086;5130.486951304863;4875.219964805632;5106.106431374504;5114.718690472023;5118.436971933093;5128.282040514331;4026.758394496325;4036.2936486114813;4039.4546736190678;4043.0889759373204;4043.6967227457912;3799;3833.310004199243;3999.4600728901664;4017.758934463927;4026.9597304027025;3943.152222272225;3955.564887862333;3982.4623675803687;3989.4866234272367;4003.519577650686;3984.4820173377566;3999.140184860269;3999.680025597945;4002.399640053986;4008.378701301274;3499.037764614726;3565.8573657053685;3570.6786389224835;3582.247727977128;3584.8566057357675;4838.177509823338;4856.61147108234;4856.805727770885;4904.411470623548;4912.5578697917;4588.7476188809605;4589.701669391512;4589.977050114761;4608.516105808909;4619.722816631013;5224.346956630421;5353;5354.732263386854;5362.865928351784;5377.166539186433;3895.9805200974097;3906.257811015926;3907.2185562887535;3911.0249324091437;3913.158670885745;5515.61390702651;5649.604527683064;5655.462731040545;5672.773089076432;5677.574181936371;3956.9604303956594;3964.345882929342;3964.742291751027;3969.6824254059607;3977.204559088194;3836.271108489378;4007.579204183577;4061.8578349757618;4064;4067.51189857219;4610.746408947473;4617.907641847211;4623.953760462419;4627.259638457831;4636.281376386665;5389.622726409192;5407.080796264644;5413.242146099549;5421.484958928895;5424.566034717213;1335.7996300554994;1357.3349058961037;1378.9448422063006;1382.3295701584723;1418.8368337641098;974.5955428497094;977.2426369563645;986.4919566423155;987.3828856964398;988.7379844341256;4657.720536767804;4661.417322834645;4673.649476289292;4683.508231635629;4729.101470720552;5498.477644623755;5515.806946756844;5517.393086760533;5519.034169020405;5520.696361700145;4533.365328853963;4670.719756814602;4677.64917631179;4677.789499472532;4695.553922377437;2972.8810847565856;3002.504586743207;3015.6079709637606;3020.5771192033135;3026.122424496871;5221.712805795718;5250.133727934848;5265.157574788015;5272.571040326145;5273.973630131902;5477.315335583052;5748.45389687979;5777.393373695785;5798.449147330997;5803.883922321615;5254.553362964114;5273.841784746463;5277.102892508359;5298.576113910878;5299.3905700844125;5586.916196256978;5588.776448941997;5628.212050313042;5649.6327738696855;5652.010898092735;5222.033923724123;5522.116461366162;5527.364353099445;5531.640443371168;5544.61187716856;5223.738813059408;5230.372355317234;5236.9738151309;5260.263563101093;5293.814716484904;3892.9416058758575;3905.9414108787823;3915.0995271088377;3925.4700615417696;3926.5680775114142;5313.1764576490705;5317.8404647860625;5403.783848646168;5612.410696876769;5625.915611265917;5397.622166448468;5400.243965844864;5403.918941215807;5405.78376864921;5408.161734931092;5378.327709036371;5413.945860541502;5415.891682166256;5417.83746487606;5421.647592906448;5143.6399452037995;5275;5288.762005709829;5303.946960530346;5348.384935732441;5395.676259424447;5405.648632838853;5416.783328666809;5418.078926582411;5432.375276843213;5238.319018527567;5273.736313184402;5275.287836142072;5285.392179899361;5290.936534751373 22:52:16 INFO - PROCESS | 19979 | |5;yui.html;709.4927127104121;739.3530660671912;750.2197714377052;753.7286576832339;754.0875540595879;11521.711957201063;12915.677108072292;13489;13497.730045399087;13543.255120968342;13651.658708532266;13705.109167904104;13746.58760237192;13796.31018449076;13802.171869687825;630.5428564290899;792.6472719639748;797.8484088023285;798.3812545277399;798.4490701416033;761.6191904047976;787.263908245792;793.4049462902823;793.9444238903279;794.086800179795;823.2590668398459;824.9422540422173;826.5164878546058;826.7230477789948;826.7561069484517;654.9181352330959;780.5121798875703;822.3585603229461;823.4318320358963;824.72371755462;587.3803137689736;588.7703795519708;588.9528837692974;589.1486801571731;589.1604463639339;11895.286282822972;11932.105092118127;11935.462904169333;11970.700732481671;11976.820347694791;11438.885611143949;11969.940150299193;12152.331621760799;12325.876741232652;12403.813942790865;9783.168430683401;9920.553575089138;9927.50362481873;9994.500274986294;10186.745331366701;3244.8702051917894;3268.607767067967;3276.3938671345877;3296.75274354422;3374.8481318340732;48534.51465485335;48616;48723.512764872256;48851.51148488505;49179.262311065366;9396.013418591087;9482.620695172254;9539.47532885684;9632.711018669452;9721.805563888682;17096;17298.22158002893;17326.133693315285;17351.56621084483;17361.913190433967;6688.230853451818;6707;6753.45972322213;6829.043933849265;6873.690683919235;3724.366857634209;3765.548134223911;3794.6964242860504;3851.345271303885;3857.864974725871;2865.226388874992;2898.289918969866;2925.195571217932;2932.2669332666833;2932.677405485395;494.66362873245816;517.1983425690165;532.9280547126166;534.5670007294104;535.7910414938177;390.65036792071504;538.2249560632677;555.491725071555;564.2608183279916;583.3670467542763;6965.895511567331;7054.541454805421;7203.063601731741;7257.673404696801;7446.292602202782;476.27368263397904;521.8956208758264;543.1960698166736;555.1312196412601;562.6174201542908;3270.1824543864036;3388.5933687957604;3410.897673069812;3442.8794992175153;3457.2566898117025;49852.75073624681;51306.23040654393;52284.738576306874;52735;52810;42899.78550107229;44071.55928440738;44090.91361613582;44281;44427.333589996175;37484.25031499355;37588.060298492754;38809.80595097006;40427.797861010506;41493;6662.900056499253;7138.464615153988;7143.392811611071;7230.45771567124;7323.560586364622;25106;26097.869510652326;26928.596071058557;27320;27597.31006724848;36821.44767828538;37090.25819483649;37399.252014959005;38709.419358710205;39514.604853952245;9414.388064775767;9552.232836925192;9599.568019439283;9791.363561368487;10019.54912028946;10865.619703310345;10979.188433908315;11106.666799996014;11512;11755.353455559683;9820.55807488679;9916.355436896578;9917.404955702681;10051.849222261526;10150.847737283799;10351.378917264989;10475.895241047798;10502.894971050191;10842.512086956263;10902.236843420884;9577.185939195246;10004.549795259085;10056.597736090474;10111.03945125212;10184.949075254874;8212.958935205525;8637.352198585006;8725.650973961225;8894.332925030778;9075.682351117679;8436.198561136682;8515.787105322417;8525.350206940504;8779.912200878165;8878.778030549289 22:52:16 INFO - PROCESS | 19979 | __end_tp_report 22:52:16 INFO - PROCESS | 19979 | __start_cc_report 22:52:16 INFO - PROCESS | 19979 | _x_x_mozilla_cycle_collect,867 22:52:16 INFO - PROCESS | 19979 | __end_cc_report 22:52:16 INFO - PROCESS | 19979 | __startTimestamp1461304336348__endTimestamp 22:52:16 INFO - PROCESS | 19979 | 22:52:16 INFO - PROCESS | 19979 | ------- Summary: start ------- 22:52:16 INFO - PROCESS | 19979 | Number of tests: 6 22:52:16 INFO - PROCESS | 19979 | 22:52:16 INFO - PROCESS | 19979 | [#0] dojo.html Cycles:165 Average:4643.65 Median:4768.45 stddev:479.96 (10.1%) stddev-sans-first:454.03 22:52:16 INFO - PROCESS | 19979 | Values: 2605.9 2690.9 2697.2 2712.0 2729.5 4597.1 4639.2 4714.2 4714.9 4742.6 4650.1 4697.1 4721.1 4739.5 4768.5 4293.2 4330.2 4374.9 4406.8 4451.7 4357.5 4367.2 4418.9 4440.0 4445.6 4233.5 4314.6 4343.9 4407.7 4412.3 4292.7 4292.8 4300.2 4304.1 4308.4 4261.1 4277.9 4288.7 4296.6 4303.1 4619.0 4649.5 4667.7 4670.5 4736.4 5039.8 5059.5 5065.3 5065.6 5068.7 4868.9 5025.4 5073.4 5078.6 5109.0 4694.9 4704.6 4706.3 4731.1 4752.3 5134.3 5155.6 5156.4 5158.1 5166.4 4838.0 4878.4 4919.1 4953.6 4961.5 5040.9 5083.3 5099.2 5109.1 5144.3 4834.2 5017.2 5027.0 5031.6 5039.5 4895.5 4922.5 4981.4 5040.1 5096.2 4216.3 4219.7 4220.2 4220.7 4266.2 3702.6 3711.7 3726.8 3731.3 3743.4 4226.7 4232.3 4312.4 4349.0 4349.9 4961.8 4977.1 4984.3 5001.3 5031.6 4221.9 4267.5 4277.2 4298.1 4315.6 4490.3 4494.9 4496.3 4530.5 4541.8 4762.6 4782.1 4782.3 4785.9 4816.9 4882.0 5010.1 5091.1 5094.1 5143.9 4674.8 4694.1 4695.4 4708.7 4743.5 4895.6 4900.9 4905.9 4912.0 4967.2 4931.1 4978.5 5019.8 5047.9 5143.2 4835.7 4838.8 4857.5 4904.5 4908.7 4846.3 4873.1 4880.5 4891.1 4923.0 4667.2 4745.7 4815.6 4874.5 4918.5 4872.0 4909.2 4945.1 4951.1 4964.4 4824.2 4850.9 4852.0 4854.5 4895.9 22:52:16 INFO - PROCESS | 19979 | 22:52:16 INFO - PROCESS | 19979 | [#1] ext.html Cycles:180 Average:43909.11 Median:174708.19 stddev:76414.28 (43.7%) stddev-sans-first:76559.41 22:52:16 INFO - PROCESS | 19979 | Values: 586.2 595.2 599.0 608.5 647.3 27569.7 34086.0 34815.3 34836.1 34841.1 36215.5 36909.0 36931.8 37001.6 37035.8 7226.9 7493.4 7672.3 7683.0 9377.0 9541.5 9694.9 9695.4 9699.8 9701.6 9668.5 9763.8 9769.2 9770.5 9771.1 9615.0 9621.6 9649.5 9661.1 9699.9 9622.2 9967.0 9993.8 9997.6 9998.6 36361.1 36835.0 36868.1 36873.6 36908.4 2911.2 3043.9 3185.3 3231.7 3294.3 28502.9 28683.4 28688.6 28751.3 29314.6 3469.4 3473.6 3503.3 3505.0 3576.9 241466.0 242107.0 243469.0 243627.0 243641.0 49576.0 49606.0 49940.0 50036.5 50038.5 53970.0 54094.2 57590.0 59542.0 59564.4 12889.2 13037.4 13039.3 13044.1 13045.4 8886.0 9210.8 10305.2 10631.0 10658.7 17659.6 17672.6 17691.7 17765.4 17843.8 6687.0 6700.0 6891.2 6979.0 6990.7 888.5 966.6 985.5 1033.5 1041.2 27704.6 28030.7 28132.9 28325.2 30396.1 936.8 957.8 982.3 1005.1 1094.7 13787.3 14389.9 14464.9 14794.5 14827.5 345333.0 345947.0 352829.0 353212.0 354198.0 47397.8 48297.8 48321.0 48333.0 48366.8 1084.5 1165.8 1218.2 1234.2 1256.2 25673.2 27265.3 27438.7 27665.9 27860.2 40531.0 40743.2 41643.2 41643.8 41689.2 268105.0 268695.0 271262.0 271443.0 271543.5 22393.3 24772.4 25392.0 25455.2 25496.0 35759.5 35802.6 36012.6 36320.6 36729.6 30120.7 30556.8 30680.7 30995.2 31260.2 30895.5 31822.4 32007.4 32179.5 33792.8 33017.8 33040.5 33250.3 33551.0 33807.0 28816.6 29979.3 30032.2 30257.0 30288.8 23109.6 23488.6 23813.4 24018.5 24070.8 22:52:16 INFO - PROCESS | 19979 | 22:52:16 INFO - PROCESS | 19979 | [#2] jquery.html Cycles:180 Average:24553.45 Median:377.86 stddev:66264.46 (17537.0%) stddev-sans-first:66425.48 22:52:16 INFO - PROCESS | 19979 | Values: 375.7 377.1 377.2 378.5 384.2 15895.0 16497.9 17208.9 17258.6 17296.7 15753.6 16091.7 16823.2 16946.7 16949.9 4997.7 5153.2 5179.5 5185.7 5187.5 3686.8 3875.5 5069.6 5546.8 5862.8 5756.4 5797.2 5824.4 5825.0 5827.2 5533.7 5848.1 5872.8 5919.4 5924.2 3378.0 4909.3 5139.7 5165.6 5170.7 19324.6 19471.4 19495.5 20980.0 21025.7 1917.2 1927.9 1953.5 2091.4 2171.7 12842.9 12884.0 12997.8 13020.3 13500.6 1775.4 1798.8 1810.9 1868.0 1891.3 65662.3 67320.7 67875.7 68116.3 69036.7 9314.3 9395.8 9698.6 9720.9 9967.0 13110.9 13374.8 13395.3 13397.5 13420.3 6752.5 6755.7 6845.5 7207.2 7340.5 6841.0 6896.3 6933.2 7006.2 7019.7 6091.5 6112.8 6116.5 6166.3 6264.0 1632.5 1728.1 1728.3 1770.7 1782.6 793.0 851.9 883.7 884.8 1029.5 16929.7 18242.4 18407.2 18520.9 18868.2 863.3 885.2 886.5 913.8 989.4 9907.5 10363.7 10387.9 10400.9 10405.0 374836.0 407509.0 407869.0 410089.0 413351.0 51576.7 76812.0 80793.0 80962.2 82116.6 876.3 955.3 971.2 993.3 993.7 13688.5 15963.9 16657.9 16820.9 16958.2 33801.3 34262.7 34605.5 34710.7 35234.8 42661.0 42995.1 44377.3 44476.8 45280.8 7556.8 7708.9 7760.9 7829.4 8096.2 12083.9 12171.5 12215.9 12289.0 12568.1 10528.4 10575.0 10580.1 10765.5 11160.5 10630.1 10694.6 10874.9 10959.7 11277.2 10601.6 10858.9 10994.0 11156.0 11229.4 7675.8 7819.5 7978.7 8011.2 8069.4 10865.4 11012.0 11173.7 11204.6 11231.6 22:52:16 INFO - PROCESS | 19979 | 22:52:16 INFO - PROCESS | 19979 | [#3] mootools.html Cycles:180 Average:5112.37 Median:5102.66 stddev:2882.49 (56.5%) stddev-sans-first:2876.34 22:52:16 INFO - PROCESS | 19979 | Values: 1299.5 1379.6 1415.8 1487.6 1739.1 7486.7 7751.9 7812.7 7815.9 7825.8 7579.8 7797.0 7810.5 7811.1 7814.0 1983.5 2056.8 2058.6 2245.8 2294.5 2237.6 2291.9 2296.3 2298.6 2298.9 2200.9 2215.2 2216.8 2220.4 2290.1 2009.1 2211.9 2318.4 2321.8 2326.3 2327.9 2341.4 2347.1 2352.9 2353.0 7690.4 7746.7 7764.1 7764.8 7767.8 4590.3 4735.1 4743.1 4743.9 4747.1 2852.8 2935.2 2981.9 2985.8 3012.1 912.6 943.2 948.6 948.8 950.2 10707.2 10911.3 10938.1 10968.7 10984.6 4415.3 4579.5 4593.6 4595.2 4623.7 8395.5 8422.9 8455.7 8462.3 8463.8 4700.5 4707.5 4715.3 4723.2 4727.4 4329.0 4368.2 4445.2 4493.0 4536.0 3399.0 3417.6 3477.2 3494.9 3515.9 1020.2 1025.6 1032.3 1038.4 1045.9 733.3 767.1 775.6 792.3 812.0 5130.8 5132.7 5198.3 5281.8 5312.7 396.7 404.7 414.5 417.0 419.5 3336.1 3370.1 3465.9 3483.5 3518.9 9470.7 9739.0 9914.3 9945.5 9973.3 9834.8 9860.6 9868.9 9882.9 9908.3 7037.7 7416.8 7458.4 7464.5 7573.0 5087.5 5117.8 5156.0 5215.9 5232.4 8724.7 8871.8 8949.7 8972.5 8989.3 6787.3 8939.9 9076.0 9081.1 9189.8 6604.1 6658.1 6684.5 6700.7 6710.9 7146.6 7303.4 7325.8 7356.2 7363.0 6448.5 6517.1 6518.9 6531.4 6700.3 6508.9 6566.9 6594.4 6669.8 6699.5 6172.7 6244.3 6252.7 6354.6 6405.8 4262.3 4263.6 4379.5 4390.6 4450.1 4570.6 4570.9 4616.7 4639.5 4702.8 22:52:16 INFO - PROCESS | 19979 | 22:52:16 INFO - PROCESS | 19979 | [#4] prototype.html Cycles:180 Average:4479.90 Median:5117.64 stddev:1292.87 (25.3%) stddev-sans-first:1258.01 22:52:16 INFO - PROCESS | 19979 | Values: 307.9 317.9 320.5 321.8 323.4 4911.6 5098.2 5116.8 5126.7 5130.5 4875.2 5106.1 5114.7 5118.4 5128.3 4026.8 4036.3 4039.5 4043.1 4043.7 3799.0 3833.3 3999.5 4017.8 4027.0 3943.2 3955.6 3982.5 3989.5 4003.5 3984.5 3999.1 3999.7 4002.4 4008.4 3499.0 3565.9 3570.7 3582.2 3584.9 4838.2 4856.6 4856.8 4904.4 4912.6 4588.7 4589.7 4590.0 4608.5 4619.7 5224.3 5353.0 5354.7 5362.9 5377.2 3896.0 3906.3 3907.2 3911.0 3913.2 5515.6 5649.6 5655.5 5672.8 5677.6 3957.0 3964.3 3964.7 3969.7 3977.2 3836.3 4007.6 4061.9 4064.0 4067.5 4610.7 4617.9 4624.0 4627.3 4636.3 5389.6 5407.1 5413.2 5421.5 5424.6 1335.8 1357.3 1378.9 1382.3 1418.8 974.6 977.2 986.5 987.4 988.7 4657.7 4661.4 4673.6 4683.5 4729.1 5498.5 5515.8 5517.4 5519.0 5520.7 4533.4 4670.7 4677.6 4677.8 4695.6 2972.9 3002.5 3015.6 3020.6 3026.1 5221.7 5250.1 5265.2 5272.6 5274.0 5477.3 5748.5 5777.4 5798.4 5803.9 5254.6 5273.8 5277.1 5298.6 5299.4 5586.9 5588.8 5628.2 5649.6 5652.0 5222.0 5522.1 5527.4 5531.6 5544.6 5223.7 5230.4 5237.0 5260.3 5293.8 3892.9 3905.9 3915.1 3925.5 3926.6 5313.2 5317.8 5403.8 5612.4 5625.9 5397.6 5400.2 5403.9 5405.8 5408.2 5378.3 5413.9 5415.9 5417.8 5421.6 5143.6 5275.0 5288.8 5303.9 5348.4 5395.7 5405.6 5416.8 5418.1 5432.4 5238.3 5273.7 5275.3 5285.4 5290.9 22:52:16 INFO - PROCESS | 19979 | 22:52:16 INFO - PROCESS | 19979 | [#5] yui.html Cycles:180 Average:12363.78 Median:25173.71 stddev:14173.50 (56.3%) stddev-sans-first:14186.24 22:52:16 INFO - PROCESS | 19979 | Values: 709.5 739.4 750.2 753.7 754.1 11521.7 12915.7 13489.0 13497.7 13543.3 13651.7 13705.1 13746.6 13796.3 13802.2 630.5 792.6 797.8 798.4 798.4 761.6 787.3 793.4 793.9 794.1 823.3 824.9 826.5 826.7 826.8 654.9 780.5 822.4 823.4 824.7 587.4 588.8 589.0 589.1 589.2 11895.3 11932.1 11935.5 11970.7 11976.8 11438.9 11969.9 12152.3 12325.9 12403.8 9783.2 9920.6 9927.5 9994.5 10186.7 3244.9 3268.6 3276.4 3296.8 3374.8 48534.5 48616.0 48723.5 48851.5 49179.3 9396.0 9482.6 9539.5 9632.7 9721.8 17096.0 17298.2 17326.1 17351.6 17361.9 6688.2 6707.0 6753.5 6829.0 6873.7 3724.4 3765.5 3794.7 3851.3 3857.9 2865.2 2898.3 2925.2 2932.3 2932.7 494.7 517.2 532.9 534.6 535.8 390.7 538.2 555.5 564.3 583.4 6965.9 7054.5 7203.1 7257.7 7446.3 476.3 521.9 543.2 555.1 562.6 3270.2 3388.6 3410.9 3442.9 3457.3 49852.8 51306.2 52284.7 52735.0 52810.0 42899.8 44071.6 44090.9 44281.0 44427.3 37484.3 37588.1 38809.8 40427.8 41493.0 6662.9 7138.5 7143.4 7230.5 7323.6 25106.0 26097.9 26928.6 27320.0 27597.3 36821.4 37090.3 37399.3 38709.4 39514.6 9414.4 9552.2 9599.6 9791.4 10019.5 10865.6 10979.2 11106.7 11512.0 11755.4 9820.6 9916.4 9917.4 10051.8 10150.8 10351.4 10475.9 10502.9 10842.5 10902.2 9577.2 10004.5 10056.6 10111.0 10184.9 8213.0 8637.4 8725.7 8894.3 9075.7 8436.2 8515.8 8525.4 8779.9 8878.8 22:52:16 INFO - PROCESS | 19979 | -------- Summary: end -------- 22:52:16 INFO - PROCESS | 19979 | 22:52:17 INFO - TEST-INFO | 19979: exit 0 22:52:17 INFO - TEST-OK | dromaeo_css | took 1118551ms 22:52:17 INFO - TEST-START | kraken 22:52:17 INFO - operating with platform_type : linux_ 22:52:17 INFO - Initialising browser for kraken test... 22:52:17 INFO - TEST-INFO | started process 20158 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZK4wNE/profile http://localhost:49900/getInfo.html) 22:52:21 INFO - PROCESS | 20158 | __metrics Screen width/height:1600/1200 22:52:21 INFO - PROCESS | 20158 | colorDepth:24 22:52:21 INFO - PROCESS | 20158 | Browser inner width/height: 1024/697 22:52:21 INFO - PROCESS | 20158 | __metrics 22:52:22 ERROR - PROCESS | 20158 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:52:23 INFO - TEST-INFO | 20158: exit 0 22:52:23 INFO - Browser initialized. 22:52:23 INFO - Running cycle 1/1 for kraken test... 22:52:23 INFO - TEST-INFO | started process 20242 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZK4wNE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:52:35 INFO - PROCESS | 20242 | RSS: Main: 154984448 22:52:35 INFO - PROCESS | 20242 | 22:52:38 INFO - PROCESS | 20242 | Cycle 1(1): loaded http://localhost:49900/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49900/tests/kraken/driver.html?testName=audio-beat-detection) 22:52:38 INFO - PROCESS | 20242 | RSS: Main: 210644992 22:52:38 INFO - PROCESS | 20242 | 22:52:41 INFO - PROCESS | 20242 | Cycle 1(1): loaded http://localhost:49900/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49900/tests/kraken/driver.html?testName=audio-dft) 22:52:42 INFO - PROCESS | 20242 | RSS: Main: 195579904 22:52:42 INFO - PROCESS | 20242 | 22:52:45 INFO - PROCESS | 20242 | Cycle 1(1): loaded http://localhost:49900/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49900/tests/kraken/driver.html?testName=audio-fft) 22:52:46 INFO - PROCESS | 20242 | RSS: Main: 266137600 22:52:46 INFO - PROCESS | 20242 | 22:52:48 INFO - PROCESS | 20242 | Cycle 1(1): loaded http://localhost:49900/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49900/tests/kraken/driver.html?testName=audio-oscillator) 22:52:48 INFO - PROCESS | 20242 | RSS: Main: 174739456 22:52:48 INFO - PROCESS | 20242 | 22:52:51 INFO - PROCESS | 20242 | Cycle 1(1): loaded http://localhost:49900/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49900/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:52:51 INFO - PROCESS | 20242 | RSS: Main: 179126272 22:52:51 INFO - PROCESS | 20242 | 22:52:54 INFO - PROCESS | 20242 | Cycle 1(1): loaded http://localhost:49900/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49900/tests/kraken/driver.html?testName=imaging-darkroom) 22:52:55 INFO - PROCESS | 20242 | RSS: Main: 214577152 22:52:55 INFO - PROCESS | 20242 | 22:52:58 INFO - PROCESS | 20242 | Cycle 1(1): loaded http://localhost:49900/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49900/tests/kraken/driver.html?testName=imaging-desaturate) 22:52:59 INFO - PROCESS | 20242 | RSS: Main: 214794240 22:52:59 INFO - PROCESS | 20242 | 22:53:02 INFO - PROCESS | 20242 | Cycle 1(1): loaded http://localhost:49900/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49900/tests/kraken/driver.html?testName=json-parse-financial) 22:53:03 INFO - PROCESS | 20242 | RSS: Main: 215498752 22:53:03 INFO - PROCESS | 20242 | 22:53:04 INFO - PROCESS | 20242 | Cycle 1(1): loaded http://localhost:49900/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49900/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:53:05 INFO - PROCESS | 20242 | RSS: Main: 202706944 22:53:05 INFO - PROCESS | 20242 | 22:53:07 INFO - PROCESS | 20242 | Cycle 1(1): loaded http://localhost:49900/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49900/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:53:07 INFO - PROCESS | 20242 | RSS: Main: 206639104 22:53:07 INFO - PROCESS | 20242 | 22:53:09 INFO - PROCESS | 20242 | Cycle 1(1): loaded http://localhost:49900/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49900/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:53:10 INFO - PROCESS | 20242 | RSS: Main: 216616960 22:53:10 INFO - PROCESS | 20242 | 22:53:13 INFO - PROCESS | 20242 | Cycle 1(1): loaded http://localhost:49900/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49900/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:53:13 INFO - PROCESS | 20242 | RSS: Main: 225210368 22:53:13 INFO - PROCESS | 20242 | 22:53:16 INFO - PROCESS | 20242 | Cycle 1(1): loaded http://localhost:49900/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49900/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:53:17 INFO - PROCESS | 20242 | RSS: Main: 218071040 22:53:17 INFO - PROCESS | 20242 | 22:53:19 INFO - PROCESS | 20242 | Cycle 1(1): loaded http://localhost:49900/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49900/tests/kraken/driver.html?testName=ai-astar) 22:53:19 INFO - PROCESS | 20242 | RSS: Main: 281268224 22:53:19 INFO - PROCESS | 20242 | 22:53:19 INFO - PROCESS | 20242 | __start_tp_report 22:53:19 INFO - PROCESS | 20242 | _x_x_mozilla_page_load 22:53:19 INFO - PROCESS | 20242 | _x_x_mozilla_page_load_details 22:53:19 INFO - PROCESS | 20242 | |i|pagename|runs| 22:53:19 INFO - PROCESS | 20242 | |0;ai-astar;112;115;107;114;113;115;102;113;111;113 22:53:19 INFO - PROCESS | 20242 | |1;audio-beat-detection;161;138;163;184;132;157;157;132;196;132 22:53:19 INFO - PROCESS | 20242 | |2;audio-dft;161;160;163;162;162;162;162;162;162;166 22:53:19 INFO - PROCESS | 20242 | |3;audio-fft;73;74;104;118;77;73;73;106;101;74 22:53:19 INFO - PROCESS | 20242 | |4;audio-oscillator;94;94;137;93;95;93;151;93;94;138 22:53:19 INFO - PROCESS | 20242 | |5;imaging-gaussian-blur;117;117;117;117;118;117;117;117;117;117 22:53:19 INFO - PROCESS | 20242 | |6;imaging-darkroom;146;146;145;145;147;146;146;146;146;146 22:53:19 INFO - PROCESS | 20242 | |7;imaging-desaturate;95;94;95;94;95;94;95;95;95;94 22:53:19 INFO - PROCESS | 20242 | |8;json-parse-financial;65;65;64;66;64;64;64;81;63;70 22:53:19 INFO - PROCESS | 20242 | |9;json-stringify-tinderbox;64;65;64;64;65;64;64;65;64;65 22:53:19 INFO - PROCESS | 20242 | |10;stanford-crypto-aes;80;80;80;78;80;80;81;80;81;81 22:53:19 INFO - PROCESS | 20242 | |11;stanford-crypto-ccm;135;142;135;134;130;130;134;145;167;136 22:53:19 INFO - PROCESS | 20242 | |12;stanford-crypto-pbkdf2;174;174;177;175;171;176;174;176;183;178 22:53:19 INFO - PROCESS | 20242 | |13;stanford-crypto-sha256-iterative;75;74;75;72;72;72;79;74;73;74 22:53:19 INFO - PROCESS | 20242 | __end_tp_report 22:53:19 INFO - PROCESS | 20242 | __start_cc_report 22:53:19 INFO - PROCESS | 20242 | _x_x_mozilla_cycle_collect,1879 22:53:19 INFO - PROCESS | 20242 | __end_cc_report 22:53:19 INFO - PROCESS | 20242 | __startTimestamp1461304399616__endTimestamp 22:53:19 INFO - PROCESS | 20242 | 22:53:19 INFO - PROCESS | 20242 | ------- Summary: start ------- 22:53:19 INFO - PROCESS | 20242 | Number of tests: 14 22:53:19 INFO - PROCESS | 20242 | 22:53:19 INFO - PROCESS | 20242 | [#0] ai-astar Cycles:10 Average:111.50 Median:113.00 stddev:4.06 (3.6%) stddev-sans-first:4.30 22:53:19 INFO - PROCESS | 20242 | Values: 112.0 115.0 107.0 114.0 113.0 115.0 102.0 113.0 111.0 113.0 22:53:19 INFO - PROCESS | 20242 | 22:53:19 INFO - PROCESS | 20242 | [#1] audio-beat-detection Cycles:10 Average:155.20 Median:159.00 stddev:22.37 (14.1%) stddev-sans-first:23.63 22:53:19 INFO - PROCESS | 20242 | Values: 161.0 138.0 163.0 184.0 132.0 157.0 157.0 132.0 196.0 132.0 22:53:19 INFO - PROCESS | 20242 | 22:53:19 INFO - PROCESS | 20242 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:1.55 (1.0%) stddev-sans-first:1.58 22:53:19 INFO - PROCESS | 20242 | Values: 161.0 160.0 163.0 162.0 162.0 162.0 162.0 162.0 162.0 166.0 22:53:19 INFO - PROCESS | 20242 | 22:53:19 INFO - PROCESS | 20242 | [#3] audio-fft Cycles:10 Average:87.30 Median:73.00 stddev:17.74 (24.3%) stddev-sans-first:18.04 22:53:19 INFO - PROCESS | 20242 | Values: 73.0 74.0 104.0 118.0 77.0 73.0 73.0 106.0 101.0 74.0 22:53:19 INFO - PROCESS | 20242 | 22:53:19 INFO - PROCESS | 20242 | [#4] audio-oscillator Cycles:10 Average:108.20 Median:93.50 stddev:23.62 (25.3%) stddev-sans-first:24.49 22:53:19 INFO - PROCESS | 20242 | Values: 94.0 94.0 137.0 93.0 95.0 93.0 151.0 93.0 94.0 138.0 22:53:19 INFO - PROCESS | 20242 | 22:53:19 INFO - PROCESS | 20242 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 22:53:19 INFO - PROCESS | 20242 | Values: 117.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 22:53:19 INFO - PROCESS | 20242 | 22:53:19 INFO - PROCESS | 20242 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 22:53:19 INFO - PROCESS | 20242 | Values: 146.0 146.0 145.0 145.0 147.0 146.0 146.0 146.0 146.0 146.0 22:53:19 INFO - PROCESS | 20242 | 22:53:19 INFO - PROCESS | 20242 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 22:53:19 INFO - PROCESS | 20242 | Values: 95.0 94.0 95.0 94.0 95.0 94.0 95.0 95.0 95.0 94.0 22:53:19 INFO - PROCESS | 20242 | 22:53:19 INFO - PROCESS | 20242 | [#8] json-parse-financial Cycles:10 Average:66.60 Median:65.00 stddev:5.42 (8.3%) stddev-sans-first:5.72 22:53:19 INFO - PROCESS | 20242 | Values: 65.0 65.0 64.0 66.0 64.0 64.0 64.0 81.0 63.0 70.0 22:53:19 INFO - PROCESS | 20242 | 22:53:19 INFO - PROCESS | 20242 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:64.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 22:53:19 INFO - PROCESS | 20242 | Values: 64.0 65.0 64.0 64.0 65.0 64.0 64.0 65.0 64.0 65.0 22:53:19 INFO - PROCESS | 20242 | 22:53:19 INFO - PROCESS | 20242 | [#10] stanford-crypto-aes Cycles:10 Average:80.10 Median:80.00 stddev:0.88 (1.1%) stddev-sans-first:0.93 22:53:19 INFO - PROCESS | 20242 | Values: 80.0 80.0 80.0 78.0 80.0 80.0 81.0 80.0 81.0 81.0 22:53:19 INFO - PROCESS | 20242 | 22:53:19 INFO - PROCESS | 20242 | [#11] stanford-crypto-ccm Cycles:10 Average:138.80 Median:135.50 stddev:10.96 (8.1%) stddev-sans-first:11.54 22:53:19 INFO - PROCESS | 20242 | Values: 135.0 142.0 135.0 134.0 130.0 130.0 134.0 145.0 167.0 136.0 22:53:19 INFO - PROCESS | 20242 | 22:53:19 INFO - PROCESS | 20242 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.80 Median:176.00 stddev:3.19 (1.8%) stddev-sans-first:3.32 22:53:19 INFO - PROCESS | 20242 | Values: 174.0 174.0 177.0 175.0 171.0 176.0 174.0 176.0 183.0 178.0 22:53:19 INFO - PROCESS | 20242 | 22:53:19 INFO - PROCESS | 20242 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.00 Median:74.00 stddev:2.11 (2.8%) stddev-sans-first:2.20 22:53:19 INFO - PROCESS | 20242 | Values: 75.0 74.0 75.0 72.0 72.0 72.0 79.0 74.0 73.0 74.0 22:53:19 INFO - PROCESS | 20242 | -------- Summary: end -------- 22:53:19 INFO - PROCESS | 20242 | 22:53:20 INFO - TEST-INFO | 20242: exit 0 22:53:20 INFO - TEST-OK | kraken | took 63624ms 22:53:20 INFO - SUITE-END | took 1182s 22:53:20 INFO - Completed test suite (00:19:42) 22:53:20 INFO - javascript benchmark 22:53:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2605.882735276912, 2690.9327266818314, 2697.2043247242063, 2711.9864400677993, 2729.508688436082, 4597.057603191346, 4639.164950308943, 4714.222153344698, 4714.90570188596, 4742.596879265267, 4650.069986002796, 4697.131030759312, 4721.079389519045, 4739.526047395268, 4768.451628062774, 4293.227219100569, 4330.198913201052, 4374.912501749963, 4406.801693923781, 4451.666125040619, 4357.520672725997, 4367.213901497729, 4418.867433976986, 4440.045390241097, 4445.644348452132, 4233.5131459881895, 4314.633256173198, 4343.869683909487, 4407.691461597689, 4412.294032954728, 4292.656587473026, 4292.763897985609, 4300.182965236626, 4304.117655880537, 4308.4399028126145, 4261.083866968616, 4277.893052673677, 4288.721233119837, 4296.57034296571, 4303.074838909618, 4619.0, 4649.465311489154, 4667.696599721007, 4670.532946705336, 4736.4316282046375, 5039.77321020555, 5059.494050594911, 5065.290859279704, 5065.645404821664, 5068.670536415121, 4868.9269660955115, 5025.422076461217, 5073.3911930568565, 5078.5937125029905, 5109.0, 4694.882627934329, 4704.5765881070865, 4706.270528068155, 4731.101090792738, 4752.263399173134, 5134.255532947702, 5155.5617772489, 5156.432792392834, 5158.071547121479, 5166.354205724285, 4838.0, 4878.365812444359, 4919.114559379274, 4953.628477864175, 4961.479044700327, 5040.949590504048, 5083.288339632454, 5099.158638824627, 5109.054824857413, 5144.254083157921, 4834.226523756252, 5017.1721665924715, 5027.0, 5031.597472202215, 5039.521245481674, 4895.510448955147, 4922.458529561745, 4981.37732783402, 5040.143175660147, 5096.184610462308, 4216.30430978885, 4219.683523735732, 4220.198162349144, 4220.662347012231, 4266.189424009428, 3702.629737026276, 3711.721620878445, 3726.795026273581, 3731.272401881607, 3743.4010558311084, 4226.704130710882, 4232.30167022444, 4312.417823593837, 4348.9565104349185, 4349.913001740011, 4961.801527938842, 4977.104121258136, 4984.27727979441, 5001.349824522788, 5031.597472202215, 4221.894452638647, 4267.509236437787, 4277.165952639268, 4298.075913678512, 4315.611594956469, 4490.259107247333, 4494.865154045384, 4496.348029535699, 4530.456345238526, 4541.750203738826, 4762.59517940972, 4782.067496838223, 4782.306565547907, 4785.880352991203, 4816.903661926742, 4882.0, 5010.073136469765, 5091.109055915126, 5094.133997220555, 5143.948560514347, 4674.836380726658, 4694.06118776253, 4695.389599352063, 4708.741019243975, 4743.478217396153, 4895.6083513318135, 4900.8774780630765, 4905.926411103765, 4912.042151780369, 4967.205247160581, 4931.087748766489, 4978.502149784992, 5019.799208031784, 5047.899042019212, 5143.202803565453, 4835.734034627989, 4838.830640927551, 4857.489963553776, 4904.5340692634145, 4908.705477671351, 4846.273059041172, 4873.074115917964, 4880.487548807324, 4891.119598472167, 4922.975385123052, 4667.229907065432, 4745.691530050535, 4815.566599006106, 4874.512548745239, 4918.458969513279, 4871.951280487291, 4909.239067944474, 4945.085159245551, 4951.10880041596, 4964.35463389757, 4824.204006338915, 4850.927236091532, 4852.0164706931555, 4854.490278520704, 4895.853124406273], "value": 4613.858102244382, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.1822757253632, 595.1756816808721, 598.9670568118758, 608.5192697768764, 647.2588885725844, 27569.724302756968, 34086.0, 34815.30369392611, 34836.129096772594, 34841.12897177565, 36215.4567681485, 36909.0, 36931.81534092333, 37001.62998370016, 37035.81482092586, 7226.927730722704, 7493.4005279577505, 7672.309492145706, 7683.0, 9377.0154133816, 9541.475218862959, 9694.903050969506, 9695.418274903494, 9699.757506062335, 9701.563429645683, 9668.516574171299, 9763.755906102333, 9769.218462522982, 9770.511474426286, 9771.071748183947, 9615.0, 9621.615135394575, 9649.469279189641, 9661.13049825519, 9699.90300096997, 9622.230221582327, 9966.950165249127, 9993.750156246078, 9997.550110244983, 9998.55006524701, 36361.09097272563, 36835.0, 36868.07829804276, 36873.63126368729, 36908.446373304425, 2911.243076800026, 3043.923901902448, 3185.2992341684794, 3231.6929891660257, 3294.3246634439884, 28502.857485712648, 28683.426331473253, 28688.585478910638, 28751.28121796951, 29314.560281595794, 3469.3755124077657, 3473.565804274466, 3503.2993401319836, 3504.9649503505148, 3576.928461430783, 241466.0, 242107.0, 243469.0, 243627.0, 243641.0, 49576.0, 49606.0, 49940.0, 50036.499635003915, 50038.49961500411, 53969.95225358114, 54094.18858717122, 57590.0, 59542.0, 59564.404355955885, 12889.226646401246, 13037.413316400594, 13039.282839443922, 13044.086913916124, 13045.412956416983, 8885.955570222237, 9210.76973075665, 10305.175585953106, 10631.043206111488, 10658.73353166177, 17659.55851103707, 17672.646547068987, 17691.73462398065, 17765.378211762527, 17843.821561784214, 6686.966565167143, 6699.9665001674675, 6891.241963384024, 6979.0, 6990.650467476606, 888.5024386343669, 966.6278482784179, 985.4530735441755, 1033.534909290807, 1041.234692501011, 27704.584431233547, 28030.719692803217, 28132.85933570319, 28325.150245492667, 30396.088117356514, 936.817320622472, 957.8371676814958, 982.2731178927543, 1005.0954141272913, 1094.682542062793, 13787.276590426196, 14389.928050359891, 14464.927675361767, 14794.482193123189, 14827.481038163829, 345333.0, 345947.0, 352829.0, 353212.0, 354198.0, 47397.763011184725, 48297.75851120722, 48321.0, 48333.0, 48366.75816620894, 1084.5228099636136, 1165.8484397028333, 1218.2081646929566, 1234.2286071205317, 1256.1520973342956, 25673.229803105936, 27265.31836704098, 27438.725612743616, 27665.861670691516, 27860.16419507418, 40531.0, 40743.1851362977, 41643.16713665771, 41643.7917810409, 41689.1662166761, 268105.0, 268695.0, 271262.0, 271443.0, 271543.49597763986, 22393.32820015402, 24772.38069048288, 25392.0, 25455.236342909742, 25496.0, 35759.46360804538, 35802.64197357993, 36012.60874544967, 36320.63679363278, 36729.63270367369, 30120.698793012667, 30556.84721576378, 30680.693193067782, 30995.225119372197, 31260.218494536908, 30895.536566951963, 31822.36355272928, 32007.359852803278, 32179.51730723994, 33792.83103584466, 33017.834910825295, 33040.50439243461, 33250.315648751595, 33551.0, 33807.0, 28816.58777915475, 29979.250518737204, 30032.249193769458, 30257.0, 30288.84855575708, 23109.632094656863, 23488.64767028462, 23813.404664883517, 24018.51962960696, 24070.759292406852], "value": 17259.53866278001, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.7013174526251, 377.1420019455736, 377.2285675793003, 378.48148037189054, 384.2027792330914, 15895.0, 16497.917510412448, 17208.913955430206, 17258.568535786595, 17296.654066918654, 15753.60615984601, 16091.678166436664, 16823.242954067067, 16946.745798813026, 16949.91525042373, 4997.700137991723, 5153.2270159476, 5179.482051794809, 5185.688858668492, 5187.507186817265, 3686.7972261525606, 3875.476810630571, 5069.569086627623, 5546.805861794838, 5862.794802181925, 5756.366799652035, 5797.246357973458, 5824.388439213885, 5825.0, 5827.1550625159325, 5533.6956467394275, 5848.093545500455, 5872.765089396419, 5919.437653422897, 5924.2298501195, 3377.9662203377898, 4909.3126962225315, 5139.743012849342, 5165.63840531163, 5170.715610641413, 19324.613507729766, 19471.4158575243, 19495.512612184666, 20980.0, 21025.68461473079, 1917.1851962915844, 1927.8554108441922, 1953.540917884296, 2091.383042002613, 2171.7176767020346, 12842.871571284355, 12884.0, 12997.805032924514, 13020.283884386356, 13500.594982150551, 1775.4052392448416, 1798.7931387890428, 1810.900400477973, 1867.9533011674816, 1891.300218918995, 65662.3433765661, 67320.66339668319, 67875.66062169657, 68116.3188368115, 69036.65481672609, 9314.254859611216, 9395.765105872408, 9698.563564639608, 9720.902790971999, 9966.950165249273, 13110.868891311156, 13374.799378009338, 13395.330233488286, 13397.53108641193, 13420.261885596386, 6752.493562982698, 6755.662216889136, 6845.520813543004, 7207.243239459886, 7340.4861659684375, 6841.0, 6896.3103689631635, 6933.237343892168, 7006.159260888726, 7019.684114214872, 6091.482224011009, 6112.816615501542, 6116.510679145657, 6166.321704612489, 6263.96868015657, 1632.4531282020419, 1728.1186594836724, 1728.260706779743, 1770.663573920951, 1782.5543614096475, 792.9960350198328, 851.9105493923173, 883.6774577279375, 884.8053428245776, 1029.5367084811865, 16929.661406771796, 18242.361517346828, 18407.171677274553, 18520.907395462935, 18868.15093320804, 863.2834747159842, 885.2210055151554, 886.4548302793736, 913.7532866126242, 989.3717489394287, 9907.455089969977, 10363.740906477247, 10387.94806025965, 10400.895991040145, 10405.0, 374836.0, 407509.0, 407869.0, 410089.0, 413351.0, 51576.74211628918, 76812.0, 80793.0, 80962.19037809546, 82116.58941705253, 876.2770714160715, 955.302629080761, 971.223021582731, 993.2749093161888, 993.7018894331671, 13688.452461901412, 15963.920180399024, 16657.91671041637, 16820.915895420443, 16958.236879340213, 33801.3239735199, 34262.657373425944, 34605.48091778575, 34710.65289347175, 35234.8238258807, 42661.0, 42995.140097198506, 44377.33433998557, 44476.777616111714, 45280.77359613313, 7556.8488630228185, 7708.922910771045, 7760.92239077602, 7829.373650108091, 8096.230858068474, 12083.879161208628, 12171.513139474322, 12215.877841221474, 12289.0, 12568.120231584067, 10528.36829790215, 10574.98814071343, 10580.100691441006, 10765.46172691378, 11160.49777760019, 10630.149588032784, 10694.572217111228, 10874.891251087387, 10959.671209863716, 11277.210595258253, 10601.575936962436, 10858.945705271422, 10994.0, 11156.0, 11229.38238396896, 7675.769726908202, 7819.452638315263, 7978.680852765824, 8011.198880111942, 8069.3544516439715, 10865.402402867918, 11012.0, 11173.664790056311, 11204.551817927191, 11231.55073797039], "value": 8420.023840206923, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1299.4737131461761, 1379.5585412667945, 1415.8159439272897, 1487.6057844671163, 1739.1130523433046, 7486.663100160492, 7751.883721744179, 7812.687492500293, 7815.882761758571, 7825.765227043191, 7579.810504737385, 7796.961015194916, 7810.453268271223, 7811.140774514813, 7814.023247094114, 1983.4743792894894, 2056.794320567946, 2058.6294466995937, 2245.8091062259687, 2294.506681063571, 2237.641977283635, 2291.873946932918, 2296.2651951375565, 2298.586254474194, 2298.908043678259, 2200.9449763755874, 2215.1582398688556, 2216.8004879560835, 2220.367195349326, 2290.1183044527893, 2009.1461129020108, 2211.8894055297333, 2318.4435735423463, 2321.8258630602686, 2326.31373744744, 2327.895244713975, 2341.4263505441277, 2347.0963678983544, 2352.9058837646476, 2353.011735071274, 7690.423218258597, 7746.728864489716, 7764.145943946161, 7764.767056988299, 7767.8446431071625, 4590.288505281686, 4735.076660051292, 4743.051389722069, 4743.928841067387, 4747.074320507502, 2852.8003039787222, 2935.222166125978, 2981.910542683723, 2985.805922615045, 3012.0963710886867, 912.5847739278612, 943.1605870775015, 948.6063283737241, 948.7628092976756, 950.2065775077818, 10707.196960228013, 10911.345319280868, 10938.070264027567, 10968.725781855437, 10984.560617575367, 4415.337699345059, 4579.450465944108, 4593.586577208067, 4595.218812801765, 4623.688155922039, 8395.496270223806, 8422.915770842335, 8455.704050358208, 8462.323014158852, 8463.788405289793, 4700.529947005341, 4707.482176960531, 4715.339852420664, 4723.173444647242, 4727.385439892861, 4328.956710432855, 4368.191884501377, 4445.222086134913, 4493.0115374617535, 4535.9773201133785, 3398.9972957977457, 3417.6069751978343, 3477.165480284764, 3494.930101397958, 3515.8945231643092, 1020.2348238820884, 1025.6153942271649, 1032.26193271811, 1038.3769738157046, 1045.8849526552226, 733.2630706140295, 767.1484652036236, 775.5540564175622, 792.2750683124876, 812.0417906869832, 5130.820421285312, 5132.727490135131, 5198.2722418861385, 5281.762320695578, 5312.681239125587, 396.6648182285964, 404.6904118349465, 414.5398607545622, 416.9833206671699, 419.46727655877476, 3336.115929278743, 3370.1069216657606, 3465.878694245689, 3483.4600636901323, 3518.9296214075575, 9470.715878523655, 9738.95130524357, 9914.256430767577, 9945.45300008492, 9973.252006099572, 9834.75413114678, 9860.605575777032, 9868.851967220497, 9882.851757223647, 9908.306418550776, 7037.7184912602925, 7416.7774966751085, 7458.440616953641, 7464.477486575887, 7573.015507983927, 5087.491250874883, 5117.820876269313, 5155.9742201288755, 5215.869603259949, 5232.398274198364, 8724.69463568772, 8871.778205544913, 8949.686760963335, 8972.461652300883, 8989.280857531512, 6787.321267873173, 8939.910600893907, 9076.0, 9081.137291957253, 9189.770255743393, 6604.14146160996, 6658.067870498037, 6684.498662600227, 6700.6984685688285, 6710.899336510054, 7146.642667866482, 7303.415726741954, 7325.7802265932105, 7356.154042284991, 7363.042804435389, 6448.484121270381, 6517.087607735016, 6518.934810651833, 6531.444827189742, 6700.329967003261, 6508.9349106508325, 6566.868662626625, 6594.373534514213, 6669.833254168685, 6699.497537684596, 6172.660503672341, 6244.2819075806865, 6252.749890004349, 6354.586951848115, 6405.775797847053, 4262.339337402707, 4263.637590804692, 4379.4525684289465, 4390.560943905584, 4450.087732014865, 4570.588647021784, 4570.931436028529, 4616.746078965689, 4639.536046395334, 4702.811887524461], "value": 4041.659724354861, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [307.8568465663466, 317.89350567559865, 320.47762147699245, 321.81656455820183, 323.40977715668896, 4911.582515486179, 5098.2097774844915, 5116.846494605164, 5126.692398456086, 5130.486951304863, 4875.219964805632, 5106.106431374504, 5114.718690472023, 5118.436971933093, 5128.282040514331, 4026.758394496325, 4036.2936486114813, 4039.4546736190678, 4043.0889759373204, 4043.6967227457912, 3799.0, 3833.310004199243, 3999.4600728901664, 4017.758934463927, 4026.9597304027025, 3943.152222272225, 3955.564887862333, 3982.4623675803687, 3989.4866234272367, 4003.519577650686, 3984.4820173377566, 3999.140184860269, 3999.680025597945, 4002.399640053986, 4008.378701301274, 3499.037764614726, 3565.8573657053685, 3570.6786389224835, 3582.247727977128, 3584.8566057357675, 4838.177509823338, 4856.61147108234, 4856.805727770885, 4904.411470623548, 4912.5578697917, 4588.7476188809605, 4589.701669391512, 4589.977050114761, 4608.516105808909, 4619.722816631013, 5224.346956630421, 5353.0, 5354.732263386854, 5362.865928351784, 5377.166539186433, 3895.9805200974097, 3906.257811015926, 3907.2185562887535, 3911.0249324091437, 3913.158670885745, 5515.61390702651, 5649.604527683064, 5655.462731040545, 5672.773089076432, 5677.574181936371, 3956.9604303956594, 3964.345882929342, 3964.742291751027, 3969.6824254059607, 3977.204559088194, 3836.271108489378, 4007.579204183577, 4061.8578349757618, 4064.0, 4067.51189857219, 4610.746408947473, 4617.907641847211, 4623.953760462419, 4627.259638457831, 4636.281376386665, 5389.622726409192, 5407.080796264644, 5413.242146099549, 5421.484958928895, 5424.566034717213, 1335.7996300554994, 1357.3349058961037, 1378.9448422063006, 1382.3295701584723, 1418.8368337641098, 974.5955428497094, 977.2426369563645, 986.4919566423155, 987.3828856964398, 988.7379844341256, 4657.720536767804, 4661.417322834645, 4673.649476289292, 4683.508231635629, 4729.101470720552, 5498.477644623755, 5515.806946756844, 5517.393086760533, 5519.034169020405, 5520.696361700145, 4533.365328853963, 4670.719756814602, 4677.64917631179, 4677.789499472532, 4695.553922377437, 2972.8810847565856, 3002.504586743207, 3015.6079709637606, 3020.5771192033135, 3026.122424496871, 5221.712805795718, 5250.133727934848, 5265.157574788015, 5272.571040326145, 5273.973630131902, 5477.315335583052, 5748.45389687979, 5777.393373695785, 5798.449147330997, 5803.883922321615, 5254.553362964114, 5273.841784746463, 5277.102892508359, 5298.576113910878, 5299.3905700844125, 5586.916196256978, 5588.776448941997, 5628.212050313042, 5649.6327738696855, 5652.010898092735, 5222.033923724123, 5522.116461366162, 5527.364353099445, 5531.640443371168, 5544.61187716856, 5223.738813059408, 5230.372355317234, 5236.9738151309, 5260.263563101093, 5293.814716484904, 3892.9416058758575, 3905.9414108787823, 3915.0995271088377, 3925.4700615417696, 3926.5680775114142, 5313.1764576490705, 5317.8404647860625, 5403.783848646168, 5612.410696876769, 5625.915611265917, 5397.622166448468, 5400.243965844864, 5403.918941215807, 5405.78376864921, 5408.161734931092, 5378.327709036371, 5413.945860541502, 5415.891682166256, 5417.83746487606, 5421.647592906448, 5143.6399452037995, 5275.0, 5288.762005709829, 5303.946960530346, 5348.384935732441, 5395.676259424447, 5405.648632838853, 5416.783328666809, 5418.078926582411, 5432.375276843213, 5238.319018527567, 5273.736313184402, 5275.287836142072, 5285.392179899361, 5290.936534751373], "value": 4073.275732665007, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [709.4927127104121, 739.3530660671912, 750.2197714377052, 753.7286576832339, 754.0875540595879, 11521.711957201063, 12915.677108072292, 13489.0, 13497.730045399087, 13543.255120968342, 13651.658708532266, 13705.109167904104, 13746.58760237192, 13796.31018449076, 13802.171869687825, 630.5428564290899, 792.6472719639748, 797.8484088023285, 798.3812545277399, 798.4490701416033, 761.6191904047976, 787.263908245792, 793.4049462902823, 793.9444238903279, 794.086800179795, 823.2590668398459, 824.9422540422173, 826.5164878546058, 826.7230477789948, 826.7561069484517, 654.9181352330959, 780.5121798875703, 822.3585603229461, 823.4318320358963, 824.72371755462, 587.3803137689736, 588.7703795519708, 588.9528837692974, 589.1486801571731, 589.1604463639339, 11895.286282822972, 11932.105092118127, 11935.462904169333, 11970.700732481671, 11976.820347694791, 11438.885611143949, 11969.940150299193, 12152.331621760799, 12325.876741232652, 12403.813942790865, 9783.168430683401, 9920.553575089138, 9927.50362481873, 9994.500274986294, 10186.745331366701, 3244.8702051917894, 3268.607767067967, 3276.3938671345877, 3296.75274354422, 3374.8481318340732, 48534.51465485335, 48616.0, 48723.512764872256, 48851.51148488505, 49179.262311065366, 9396.013418591087, 9482.620695172254, 9539.47532885684, 9632.711018669452, 9721.805563888682, 17096.0, 17298.22158002893, 17326.133693315285, 17351.56621084483, 17361.913190433967, 6688.230853451818, 6707.0, 6753.45972322213, 6829.043933849265, 6873.690683919235, 3724.366857634209, 3765.548134223911, 3794.6964242860504, 3851.345271303885, 3857.864974725871, 2865.226388874992, 2898.289918969866, 2925.195571217932, 2932.2669332666833, 2932.677405485395, 494.66362873245816, 517.1983425690165, 532.9280547126166, 534.5670007294104, 535.7910414938177, 390.65036792071504, 538.2249560632677, 555.491725071555, 564.2608183279916, 583.3670467542763, 6965.895511567331, 7054.541454805421, 7203.063601731741, 7257.673404696801, 7446.292602202782, 476.27368263397904, 521.8956208758264, 543.1960698166736, 555.1312196412601, 562.6174201542908, 3270.1824543864036, 3388.5933687957604, 3410.897673069812, 3442.8794992175153, 3457.2566898117025, 49852.75073624681, 51306.23040654393, 52284.738576306874, 52735.0, 52810.0, 42899.78550107229, 44071.55928440738, 44090.91361613582, 44281.0, 44427.333589996175, 37484.25031499355, 37588.060298492754, 38809.80595097006, 40427.797861010506, 41493.0, 6662.900056499253, 7138.464615153988, 7143.392811611071, 7230.45771567124, 7323.560586364622, 25106.0, 26097.869510652326, 26928.596071058557, 27320.0, 27597.31006724848, 36821.44767828538, 37090.25819483649, 37399.252014959005, 38709.419358710205, 39514.604853952245, 9414.388064775767, 9552.232836925192, 9599.568019439283, 9791.363561368487, 10019.54912028946, 10865.619703310345, 10979.188433908315, 11106.666799996014, 11512.0, 11755.353455559683, 9820.55807488679, 9916.355436896578, 9917.404955702681, 10051.849222261526, 10150.847737283799, 10351.378917264989, 10475.895241047798, 10502.894971050191, 10842.512086956263, 10902.236843420884, 9577.185939195246, 10004.549795259085, 10056.597736090474, 10111.03945125212, 10184.949075254874, 8212.958935205525, 8637.352198585006, 8725.650973961225, 8894.332925030778, 9075.682351117679, 8436.198561136682, 8515.787105322417, 8525.350206940504, 8779.912200878165, 8878.778030549289], "value": 5707.925151641941, "unit": "score"}], "name": "dromaeo_css", "value": 6308.209151991558, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 115.0, 107.0, 114.0, 113.0, 115.0, 102.0, 113.0, 111.0, 113.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 138.0, 163.0, 184.0, 132.0, 157.0, 157.0, 132.0, 196.0, 132.0], "value": 155.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 163.0, 162.0, 162.0, 162.0, 162.0, 162.0, 162.0, 166.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 104.0, 118.0, 77.0, 73.0, 73.0, 106.0, 101.0, 74.0], "value": 87.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 137.0, 93.0, 95.0, 93.0, 151.0, 93.0, 94.0, 138.0], "value": 108.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 145.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 66.0, 64.0, 64.0, 64.0, 81.0, 63.0, 70.0], "value": 66.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 64.0, 65.0, 64.0, 64.0, 65.0, 64.0, 65.0], "value": 64.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 80.0, 78.0, 80.0, 80.0, 81.0, 80.0, 81.0, 81.0], "value": 80.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 142.0, 135.0, 134.0, 130.0, 130.0, 134.0, 145.0, 167.0, 136.0], "value": 138.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 174.0, 177.0, 175.0, 171.0, 176.0, 174.0, 176.0, 183.0, 178.0], "value": 175.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 72.0, 72.0, 72.0, 79.0, 74.0, 73.0, 74.0], "value": 74.0, "unit": "score"}], "name": "kraken", "value": 1581.6999999999998, "alertThreshold": 2.0}]} 22:53:20 INFO - Return code: 0 22:53:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:53:20 ERROR - # TBPL SUCCESS # 22:53:20 INFO - Running post-action listener: _resource_record_post_action 22:53:20 INFO - Running post-run listener: _resource_record_post_run 22:53:21 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 517406720; Read time: 16; Write time: 467872 22:53:21 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234246144; Read time: 0; Write time: 268740 22:53:22 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283160576; Read time: 16; Write time: 199132 22:53:22 INFO - Running post-run listener: _upload_blobber_files 22:53:22 INFO - Blob upload gear active. 22:53:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:53:22 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 22:53:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:53:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:53:22 INFO - (blobuploader) - INFO - Open directory for files ... 22:53:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:53:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:53:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:53:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:53:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:53:23 INFO - (blobuploader) - INFO - Done attempting. 22:53:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:53:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:53:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:53:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:53:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:53:24 INFO - (blobuploader) - INFO - Done attempting. 22:53:24 INFO - (blobuploader) - INFO - Iteration through files over. 22:53:24 INFO - Return code: 0 22:53:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:53:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:53:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/56cb862df4b1caab52e018a905f4ab10b00b19f7dfd3a0e837c80195597040da11adb7c1bdcce5092fd3daf984c10361f632dedb5c6f9dc9a607280a1a68ce7b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/be9fc2c22254528c94b3b22eb47a0d3b7edb5ab20bb1da512dc6927cd6d970d58bb07d7ce582e9859670af73fa80cbc350a5bf24297eab9f999fca8957c77059"} 22:53:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:53:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:53:24 INFO - Contents: 22:53:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/56cb862df4b1caab52e018a905f4ab10b00b19f7dfd3a0e837c80195597040da11adb7c1bdcce5092fd3daf984c10361f632dedb5c6f9dc9a607280a1a68ce7b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/be9fc2c22254528c94b3b22eb47a0d3b7edb5ab20bb1da512dc6927cd6d970d58bb07d7ce582e9859670af73fa80cbc350a5bf24297eab9f999fca8957c77059"} 22:53:24 INFO - Running post-run listener: copy_logs_to_upload_dir 22:53:24 INFO - Copying logs to upload dir... 22:53:24 INFO - mkdir: /builds/slave/test/build/upload/logs 22:53:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.917007 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-04-21 22:53:23.896108) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 22:53:23.899561) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1461294358.679176-739690502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/56cb862df4b1caab52e018a905f4ab10b00b19f7dfd3a0e837c80195597040da11adb7c1bdcce5092fd3daf984c10361f632dedb5c6f9dc9a607280a1a68ce7b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/be9fc2c22254528c94b3b22eb47a0d3b7edb5ab20bb1da512dc6927cd6d970d58bb07d7ce582e9859670af73fa80cbc350a5bf24297eab9f999fca8957c77059"} build_url:https://queue.taskcluster.net/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011103 build_url: 'https://queue.taskcluster.net/v1/task/c9kscWP0RhWWZ_h5gNMj5Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/56cb862df4b1caab52e018a905f4ab10b00b19f7dfd3a0e837c80195597040da11adb7c1bdcce5092fd3daf984c10361f632dedb5c6f9dc9a607280a1a68ce7b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/be9fc2c22254528c94b3b22eb47a0d3b7edb5ab20bb1da512dc6927cd6d970d58bb07d7ce582e9859670af73fa80cbc350a5bf24297eab9f999fca8957c77059"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 22:53:23.924559) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 22:53:23.924894) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1461294358.679176-739690502 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004450 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 22:53:24.007244) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 22:53:24.007619) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 22:53:24.007912) ========= ========= Total master_lag: 0.27 =========