builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-012 starttime: 1460989662.04 results: success (0) buildid: 20160418061615 builduid: 1d461389d54d42618988cbe38fbb7a21 revision: 1306c789088d5675435586edf04b9a2b70f86dec ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 07:27:42.041244) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 07:27:42.041810) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-18 07:27:42.042215) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-18 07:27:42.110129) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 07:27:42.110457) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1460989303.68382-256540036 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-18 07:27:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.2M=0s 2016-04-18 07:27:43 (43.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.106331 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 07:27:42.231146) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 07:27:42.231488) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1460989303.68382-256540036 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017842 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 07:27:42.281996) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-18 07:27:42.282430) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1306c789088d5675435586edf04b9a2b70f86dec --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 1306c789088d5675435586edf04b9a2b70f86dec --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1460989303.68382-256540036 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-18 07:27:43,706 truncating revision to first 12 chars 2016-04-18 07:27:43,706 Setting DEBUG logging. 2016-04-18 07:27:43,707 attempt 1/10 2016-04-18 07:27:43,707 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1306c789088d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-18 07:27:44,732 unpacking tar archive at: fx-team-1306c789088d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.368987 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-18 07:27:43.668938) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 07:27:43.669737) ========= script_repo_revision: 1306c789088d5675435586edf04b9a2b70f86dec ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 07:27:43.670440) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 07:27:43.670749) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 07:27:43.680666) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-04-18 07:27:43.680972) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=2c5dd2b0a310ecf02fd87158000001b4-1460989303.68382-256540036 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:27:45 INFO - MultiFileLogger online at 20160418 07:27:45 in /builds/slave/test 07:27:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 07:27:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:27:45 INFO - {'append_to_log': False, 07:27:45 INFO - 'base_work_dir': '/builds/slave/test', 07:27:45 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 07:27:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:27:45 INFO - 'branch': 'Fx-Team-Non-PGO', 07:27:45 INFO - 'buildbot_json_path': 'buildprops.json', 07:27:45 INFO - 'config_files': ('talos/linux_config.py',), 07:27:45 INFO - 'default_actions': ('clobber', 07:27:45 INFO - 'read-buildbot-config', 07:27:45 INFO - 'download-and-extract', 07:27:45 INFO - 'populate-webroot', 07:27:45 INFO - 'create-virtualenv', 07:27:45 INFO - 'install', 07:27:45 INFO - 'run-tests'), 07:27:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:27:45 INFO - 'download_minidump_stackwalk': True, 07:27:45 INFO - 'download_symbols': 'ondemand', 07:27:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:27:45 INFO - 'tooltool.py': '/tools/tooltool.py', 07:27:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:27:45 INFO - '/tools/misc-python/virtualenv.py')}, 07:27:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:27:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:27:45 INFO - 'installer_path': 'installer.exe', 07:27:45 INFO - 'log_level': 'info', 07:27:45 INFO - 'log_name': 'talos', 07:27:45 INFO - 'log_to_console': True, 07:27:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:27:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:27:45 INFO - 'opt_config_files': (), 07:27:45 INFO - 'pip_index': False, 07:27:45 INFO - 'sps_profile': False, 07:27:45 INFO - 'sps_profile_interval': 0, 07:27:45 INFO - 'suite': 'dromaeojs-e10s', 07:27:45 INFO - 'system_bits': '32', 07:27:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:27:45 INFO - 'title': 'talos-linux64-ix-012', 07:27:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:27:45 INFO - 'use_talos_json': True, 07:27:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:27:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:27:45 INFO - 'work_dir': 'build'} 07:27:45 INFO - ##### 07:27:45 INFO - ##### Running clobber step. 07:27:45 INFO - ##### 07:27:45 INFO - Running pre-action listener: _resource_record_pre_action 07:27:45 INFO - Running main action method: clobber 07:27:45 INFO - rmtree: /builds/slave/test/build 07:27:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:27:45 INFO - Running post-action listener: _resource_record_post_action 07:27:45 INFO - ##### 07:27:45 INFO - ##### Running read-buildbot-config step. 07:27:45 INFO - ##### 07:27:45 INFO - Running pre-action listener: _resource_record_pre_action 07:27:45 INFO - Running main action method: read_buildbot_config 07:27:45 INFO - Using buildbot properties: 07:27:45 INFO - { 07:27:45 INFO - "project": "", 07:27:45 INFO - "product": "firefox", 07:27:45 INFO - "script_repo_revision": "production", 07:27:45 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 07:27:45 INFO - "repository": "", 07:27:45 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 07:27:45 INFO - "buildid": "20160418061615", 07:27:45 INFO - "pgo_build": "False", 07:27:45 INFO - "basedir": "/builds/slave/test", 07:27:45 INFO - "buildnumber": 1168, 07:27:45 INFO - "slavename": "talos-linux64-ix-012", 07:27:45 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:27:45 INFO - "platform": "ubuntu64_hw", 07:27:45 INFO - "scheduler": "tests-fx-team-linux64-talos", 07:27:45 INFO - "branch": "fx-team", 07:27:45 INFO - "repo_path": "integration/fx-team", 07:27:45 INFO - "revision": "1306c789088d5675435586edf04b9a2b70f86dec", 07:27:45 INFO - "stage_platform": "linux64", 07:27:45 INFO - "builduid": "1d461389d54d42618988cbe38fbb7a21", 07:27:45 INFO - "slavebuilddir": "test" 07:27:45 INFO - } 07:27:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/T4QvblmPSfiRuWEIfeMGXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 07:27:45 INFO - Running post-action listener: _resource_record_post_action 07:27:45 INFO - ##### 07:27:45 INFO - ##### Running download-and-extract step. 07:27:45 INFO - ##### 07:27:45 INFO - Running pre-action listener: _resource_record_pre_action 07:27:45 INFO - Running main action method: download_and_extract 07:27:45 INFO - mkdir: /builds/slave/test/build/tests 07:27:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:45 INFO - https://queue.taskcluster.net/v1/task/T4QvblmPSfiRuWEIfeMGXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:27:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4QvblmPSfiRuWEIfeMGXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:27:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4QvblmPSfiRuWEIfeMGXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:27:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4QvblmPSfiRuWEIfeMGXg/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 07:27:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4QvblmPSfiRuWEIfeMGXg/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 07:27:46 INFO - Downloaded 1361 bytes. 07:27:46 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:27:46 INFO - Using the following test package requirements: 07:27:46 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 07:27:46 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:27:46 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:27:46 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:27:46 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:27:46 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:27:46 INFO - u'jsshell-linux-x86_64.zip'], 07:27:46 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:27:46 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:27:46 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 07:27:46 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:27:46 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:27:46 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:27:46 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:27:46 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:27:46 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:27:46 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:27:46 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:27:46 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:27:46 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')]} 07:27:46 INFO - https://queue.taskcluster.net/v1/task/T4QvblmPSfiRuWEIfeMGXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:27:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4QvblmPSfiRuWEIfeMGXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:27:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4QvblmPSfiRuWEIfeMGXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:27:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4QvblmPSfiRuWEIfeMGXg/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 07:27:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4QvblmPSfiRuWEIfeMGXg/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 07:27:48 INFO - Downloaded 22203755 bytes. 07:27:48 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'] 07:27:48 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 07:27:49 INFO - Return code: 0 07:27:49 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 07:27:49 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')]} 07:27:49 INFO - https://queue.taskcluster.net/v1/task/T4QvblmPSfiRuWEIfeMGXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:27:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4QvblmPSfiRuWEIfeMGXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:27:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4QvblmPSfiRuWEIfeMGXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:27:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4QvblmPSfiRuWEIfeMGXg/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 07:27:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4QvblmPSfiRuWEIfeMGXg/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 07:27:51 INFO - Downloaded 22203755 bytes. 07:27: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'] 07:27: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 07:27:53 INFO - Return code: 0 07:27:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:53 INFO - https://queue.taskcluster.net/v1/task/T4QvblmPSfiRuWEIfeMGXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:27:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4QvblmPSfiRuWEIfeMGXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:27:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4QvblmPSfiRuWEIfeMGXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:27:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4QvblmPSfiRuWEIfeMGXg/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 07:27:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4QvblmPSfiRuWEIfeMGXg/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 07:27:54 INFO - Downloaded 10845952 bytes. 07:27: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'] 07:27: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 07:27:54 INFO - Return code: 0 07:27:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:54 INFO - https://queue.taskcluster.net/v1/task/T4QvblmPSfiRuWEIfeMGXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:27:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4QvblmPSfiRuWEIfeMGXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:27:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4QvblmPSfiRuWEIfeMGXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:27:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4QvblmPSfiRuWEIfeMGXg/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 07:27:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4QvblmPSfiRuWEIfeMGXg/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 07:27:57 INFO - Downloaded 54451518 bytes. 07:27:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/T4QvblmPSfiRuWEIfeMGXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:27:57 INFO - mkdir: /builds/slave/test/properties 07:27:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:27:57 INFO - Writing to file /builds/slave/test/properties/build_url 07:27:57 INFO - Contents: 07:27:57 INFO - build_url:https://queue.taskcluster.net/v1/task/T4QvblmPSfiRuWEIfeMGXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:27:58 INFO - Running post-action listener: _resource_record_post_action 07:27:58 INFO - Running post-action listener: set_extra_try_arguments 07:27:58 INFO - ##### 07:27:58 INFO - ##### Running populate-webroot step. 07:27:58 INFO - ##### 07:27:58 INFO - Running pre-action listener: _resource_record_pre_action 07:27:58 INFO - Running main action method: populate_webroot 07:27:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:27:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:27:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:27:58 INFO - '--tppagecycles', 07:27:58 INFO - '7'], 07:27:58 INFO - 'tests': ['tsvgm']}}, 07:27:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:27:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:27:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:27:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:27:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:27:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:27:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:58 INFO - 'talos_options': ['--disable-e10s'], 07:27:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:27:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:27:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:58 INFO - 'talos_options': ['--disable-e10s'], 07:27:58 INFO - 'tests': ['damp', 'tps']}, 07:27:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:58 INFO - 'tests': ['damp', 'tps']}, 07:27:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:27:58 INFO - 'tests': ['dromaeo_dom']}, 07:27:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:27:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:27:58 INFO - 'tests': ['a11yr', 07:27:58 INFO - 'ts_paint', 07:27:58 INFO - 'tpaint', 07:27:58 INFO - 'sessionrestore', 07:27:58 INFO - 'sessionrestore_no_auto_restore', 07:27:58 INFO - 'tabpaint']}, 07:27:58 INFO - 'other-e10s': {'tests': ['a11yr', 07:27:58 INFO - 'ts_paint', 07:27:58 INFO - 'tpaint', 07:27:58 INFO - 'sessionrestore', 07:27:58 INFO - 'sessionrestore_no_auto_restore', 07:27:58 INFO - 'tabpaint']}, 07:27:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:27:58 INFO - 'ts_paint', 07:27:58 INFO - 'tpaint', 07:27:58 INFO - 'sessionrestore', 07:27:58 INFO - 'sessionrestore_no_auto_restore', 07:27:58 INFO - 'tabpaint']}, 07:27:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:27:58 INFO - 'ts_paint', 07:27:58 INFO - 'tpaint', 07:27:58 INFO - 'sessionrestore', 07:27:58 INFO - 'sessionrestore_no_auto_restore', 07:27:58 INFO - 'tabpaint']}, 07:27:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:27:58 INFO - 'tests': ['a11yr', 07:27:58 INFO - 'ts_paint', 07:27:58 INFO - 'tpaint', 07:27:58 INFO - 'sessionrestore', 07:27:58 INFO - 'sessionrestore_no_auto_restore', 07:27:58 INFO - 'tabpaint']}, 07:27:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:27:58 INFO - 'tests': ['a11yr', 07:27:58 INFO - 'ts_paint', 07:27:58 INFO - 'tpaint', 07:27:58 INFO - 'sessionrestore', 07:27:58 INFO - 'sessionrestore_no_auto_restore', 07:27:58 INFO - 'tabpaint']}, 07:27:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:27:58 INFO - 'tests': ['tsvgx', 07:27:58 INFO - 'tsvgr_opacity', 07:27:58 INFO - 'tart', 07:27:58 INFO - 'tscrollx', 07:27:58 INFO - 'cart']}, 07:27:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:27:58 INFO - 'tsvgr_opacity', 07:27:58 INFO - 'tart', 07:27:58 INFO - 'tscrollx', 07:27:58 INFO - 'cart']}, 07:27:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:58 INFO - 'talos_options': ['--disable-e10s'], 07:27:58 INFO - 'tests': ['tp5o']}, 07:27:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:58 INFO - 'tests': ['tp5o']}, 07:27:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:58 INFO - 'talos_options': ['--disable-e10s', 07:27:58 INFO - '--xperf_path', 07:27:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:27:58 INFO - 'tests': ['tp5n']}, 07:27:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:58 INFO - 'talos_options': ['--xperf_path', 07:27:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:27:58 INFO - 'tests': ['tp5n']}}, 07:27:58 INFO - 'talos.zip': {'path': '', 07:27:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:27:58 INFO - Running post-action listener: _resource_record_post_action 07:27:58 INFO - ##### 07:27:58 INFO - ##### Running create-virtualenv step. 07:27:58 INFO - ##### 07:27:58 INFO - Running pre-action listener: _resource_record_pre_action 07:27:58 INFO - Running main action method: create_virtualenv 07:27:58 INFO - Creating virtualenv /builds/slave/test/build/venv 07:27:58 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 07:27:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:27:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:27:58 INFO - Using real prefix '/usr' 07:27:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:27:58 INFO - Installing distribute.............................................................................................................................................................................................done. 07:28:00 INFO - Installing pip.................done. 07:28:00 INFO - Return code: 0 07:28:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:28:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f607976ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22567d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e5640>, '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 0x22e6540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e69d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1460989303.68382-256540036', '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 07:28:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:28:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:28:00 INFO - Using env: {'DISPLAY': ':0', 07:28:00 INFO - 'HOME': '/home/cltbld', 07:28:00 INFO - 'LANG': 'en_US.UTF-8', 07:28:00 INFO - 'LANGUAGE': 'en_US:en', 07:28:00 INFO - 'LOGNAME': 'cltbld', 07:28:00 INFO - 'MAIL': '/var/mail/cltbld', 07:28:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:00 INFO - 'MOZ_NO_REMOTE': '1', 07:28:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:00 INFO - 'NO_EM_RESTART': '1', 07:28:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:00 INFO - 'PWD': '/builds/slave/test', 07:28:00 INFO - 'SHELL': '/bin/bash', 07:28:00 INFO - 'SHLVL': '1', 07:28:00 INFO - 'TERM': 'linux', 07:28:00 INFO - 'TMOUT': '86400', 07:28:00 INFO - 'USER': 'cltbld', 07:28:00 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1460989303.68382-256540036', 07:28:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:00 INFO - '_': '/tools/buildbot/bin/python'} 07:28:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:01 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 07:28:01 INFO - Cleaning up... 07:28:01 INFO - Return code: 0 07:28:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:28:01 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')]} 07:28:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:01 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')]} 07:28:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:01 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 0x7f607976ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22567d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e5640>, '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 0x22e6540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e69d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1460989303.68382-256540036', '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 07:28:01 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 07:28:01 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 07:28:01 INFO - Using env: {'DISPLAY': ':0', 07:28:01 INFO - 'HOME': '/home/cltbld', 07:28:01 INFO - 'LANG': 'en_US.UTF-8', 07:28:01 INFO - 'LANGUAGE': 'en_US:en', 07:28:01 INFO - 'LOGNAME': 'cltbld', 07:28:01 INFO - 'MAIL': '/var/mail/cltbld', 07:28:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:01 INFO - 'MOZ_NO_REMOTE': '1', 07:28:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:01 INFO - 'NO_EM_RESTART': '1', 07:28:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:01 INFO - 'PWD': '/builds/slave/test', 07:28:01 INFO - 'SHELL': '/bin/bash', 07:28:01 INFO - 'SHLVL': '1', 07:28:01 INFO - 'TERM': 'linux', 07:28:01 INFO - 'TMOUT': '86400', 07:28:01 INFO - 'USER': 'cltbld', 07:28:01 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1460989303.68382-256540036', 07:28:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:01 INFO - '_': '/tools/buildbot/bin/python'} 07:28:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:01 INFO - Downloading/unpacking psutil>=0.7.1 07:28:01 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 07:28:01 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 07:28:01 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 07:28:01 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 07:28:01 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 07:28:01 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 07:28:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:28:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:28:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:28:03 INFO - Installing collected packages: psutil 07:28:03 INFO - Running setup.py install for psutil 07:28:03 INFO - building 'psutil._psutil_linux' extension 07:28:03 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 07:28:03 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 07:28:03 INFO - building 'psutil._psutil_posix' extension 07:28:03 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 07:28:03 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 07:28:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:28:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:28:03 INFO - Successfully installed psutil 07:28:03 INFO - Cleaning up... 07:28:03 INFO - Return code: 0 07:28:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:28:03 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')]} 07:28:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:03 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')]} 07:28:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:03 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 0x7f607976ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22567d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e5640>, '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 0x22e6540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e69d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1460989303.68382-256540036', '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 07:28:03 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 07:28:03 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 07:28:03 INFO - Using env: {'DISPLAY': ':0', 07:28:03 INFO - 'HOME': '/home/cltbld', 07:28:03 INFO - 'LANG': 'en_US.UTF-8', 07:28:03 INFO - 'LANGUAGE': 'en_US:en', 07:28:03 INFO - 'LOGNAME': 'cltbld', 07:28:03 INFO - 'MAIL': '/var/mail/cltbld', 07:28:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:03 INFO - 'MOZ_NO_REMOTE': '1', 07:28:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:03 INFO - 'NO_EM_RESTART': '1', 07:28:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:03 INFO - 'PWD': '/builds/slave/test', 07:28:03 INFO - 'SHELL': '/bin/bash', 07:28:03 INFO - 'SHLVL': '1', 07:28:03 INFO - 'TERM': 'linux', 07:28:03 INFO - 'TMOUT': '86400', 07:28:03 INFO - 'USER': 'cltbld', 07:28:03 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1460989303.68382-256540036', 07:28:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:03 INFO - '_': '/tools/buildbot/bin/python'} 07:28:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:28:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:28:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:28:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:28:06 INFO - Installing collected packages: mozsystemmonitor 07:28:06 INFO - Running setup.py install for mozsystemmonitor 07:28:06 INFO - Successfully installed mozsystemmonitor 07:28:06 INFO - Cleaning up... 07:28:06 INFO - Return code: 0 07:28:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:28:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f607976ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22567d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e5640>, '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 0x22e6540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e69d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1460989303.68382-256540036', '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 07:28:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:28:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:28:06 INFO - Using env: {'DISPLAY': ':0', 07:28:06 INFO - 'HOME': '/home/cltbld', 07:28:06 INFO - 'LANG': 'en_US.UTF-8', 07:28:06 INFO - 'LANGUAGE': 'en_US:en', 07:28:06 INFO - 'LOGNAME': 'cltbld', 07:28:06 INFO - 'MAIL': '/var/mail/cltbld', 07:28:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:06 INFO - 'MOZ_NO_REMOTE': '1', 07:28:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:06 INFO - 'NO_EM_RESTART': '1', 07:28:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:06 INFO - 'PWD': '/builds/slave/test', 07:28:06 INFO - 'SHELL': '/bin/bash', 07:28:06 INFO - 'SHLVL': '1', 07:28:06 INFO - 'TERM': 'linux', 07:28:06 INFO - 'TMOUT': '86400', 07:28:06 INFO - 'USER': 'cltbld', 07:28:06 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1460989303.68382-256540036', 07:28:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:06 INFO - '_': '/tools/buildbot/bin/python'} 07:28:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:06 INFO - Downloading/unpacking blobuploader==1.2.4 07:28:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:08 INFO - Downloading blobuploader-1.2.4.tar.gz 07:28:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:28:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:28:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:28:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:28:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:08 INFO - Downloading docopt-0.6.1.tar.gz 07:28:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:28:09 INFO - Installing collected packages: blobuploader, requests, docopt 07:28:09 INFO - Running setup.py install for blobuploader 07:28:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:28:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:28:09 INFO - Running setup.py install for requests 07:28:09 INFO - Running setup.py install for docopt 07:28:09 INFO - Successfully installed blobuploader requests docopt 07:28:09 INFO - Cleaning up... 07:28:09 INFO - Return code: 0 07:28:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:28:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:09 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 0x7f607976ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22567d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e5640>, '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 0x22e6540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e69d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1460989303.68382-256540036', '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 07:28:09 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 07:28:09 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 07:28:09 INFO - Using env: {'DISPLAY': ':0', 07:28:09 INFO - 'HOME': '/home/cltbld', 07:28:09 INFO - 'LANG': 'en_US.UTF-8', 07:28:09 INFO - 'LANGUAGE': 'en_US:en', 07:28:09 INFO - 'LOGNAME': 'cltbld', 07:28:09 INFO - 'MAIL': '/var/mail/cltbld', 07:28:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:09 INFO - 'MOZ_NO_REMOTE': '1', 07:28:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:09 INFO - 'NO_EM_RESTART': '1', 07:28:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:09 INFO - 'PWD': '/builds/slave/test', 07:28:09 INFO - 'SHELL': '/bin/bash', 07:28:09 INFO - 'SHLVL': '1', 07:28:09 INFO - 'TERM': 'linux', 07:28:09 INFO - 'TMOUT': '86400', 07:28:09 INFO - 'USER': 'cltbld', 07:28:09 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1460989303.68382-256540036', 07:28:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:09 INFO - '_': '/tools/buildbot/bin/python'} 07:28:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:28:09 INFO - Running setup.py (path:/tmp/pip-jXHvZp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:28:09 INFO - Running setup.py (path:/tmp/pip-s70tiF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:28:09 INFO - Running setup.py (path:/tmp/pip-N6OzEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:28:10 INFO - Running setup.py (path:/tmp/pip-j6SVNq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:28:10 INFO - Running setup.py (path:/tmp/pip-7rUEVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:28:10 INFO - Running setup.py (path:/tmp/pip-nko8YO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:28:10 INFO - Running setup.py (path:/tmp/pip-K72sA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:28:10 INFO - Running setup.py (path:/tmp/pip-Lo_tt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:28:10 INFO - Running setup.py (path:/tmp/pip-YWIpNx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:28:10 INFO - Running setup.py (path:/tmp/pip-F2SSyc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:28:10 INFO - Running setup.py (path:/tmp/pip-LejFiA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:28:10 INFO - Running setup.py (path:/tmp/pip-fFdWRO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:28:10 INFO - Running setup.py (path:/tmp/pip-6ABYPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:28:10 INFO - Running setup.py (path:/tmp/pip-hM70Q2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:28:10 INFO - Running setup.py (path:/tmp/pip-rN90yF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:28:10 INFO - Running setup.py (path:/tmp/pip-SLsH5x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:28:10 INFO - Running setup.py (path:/tmp/pip-5entXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:28:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:28:11 INFO - Running setup.py install for manifestparser 07:28:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:28:11 INFO - Running setup.py install for mozcrash 07:28:11 INFO - Running setup.py install for mozdebug 07:28:11 INFO - Running setup.py install for mozdevice 07:28:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:28:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:28:11 INFO - Running setup.py install for mozfile 07:28:11 INFO - Running setup.py install for mozhttpd 07:28:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:28:11 INFO - Running setup.py install for mozinfo 07:28:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:28:11 INFO - Running setup.py install for mozInstall 07:28:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:28:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:28:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:28:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:28:11 INFO - Running setup.py install for mozleak 07:28:11 INFO - Running setup.py install for mozlog 07:28:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:28:12 INFO - Running setup.py install for moznetwork 07:28:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:28:12 INFO - Running setup.py install for mozprocess 07:28:12 INFO - Running setup.py install for mozprofile 07:28:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:28:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:28:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:28:12 INFO - Running setup.py install for mozrunner 07:28:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:28:12 INFO - Running setup.py install for mozscreenshot 07:28:12 INFO - Running setup.py install for moztest 07:28:12 INFO - Running setup.py install for mozversion 07:28:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:28:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:28:12 INFO - Cleaning up... 07:28:12 INFO - Return code: 0 07:28:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:28:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:12 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 0x7f607976ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22567d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e5640>, '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 0x22e6540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e69d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1460989303.68382-256540036', '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 07:28:12 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 07:28:12 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 07:28:12 INFO - Using env: {'DISPLAY': ':0', 07:28:12 INFO - 'HOME': '/home/cltbld', 07:28:12 INFO - 'LANG': 'en_US.UTF-8', 07:28:12 INFO - 'LANGUAGE': 'en_US:en', 07:28:12 INFO - 'LOGNAME': 'cltbld', 07:28:12 INFO - 'MAIL': '/var/mail/cltbld', 07:28:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:12 INFO - 'MOZ_NO_REMOTE': '1', 07:28:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:12 INFO - 'NO_EM_RESTART': '1', 07:28:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:12 INFO - 'PWD': '/builds/slave/test', 07:28:12 INFO - 'SHELL': '/bin/bash', 07:28:12 INFO - 'SHLVL': '1', 07:28:12 INFO - 'TERM': 'linux', 07:28:12 INFO - 'TMOUT': '86400', 07:28:12 INFO - 'USER': 'cltbld', 07:28:12 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1460989303.68382-256540036', 07:28:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:12 INFO - '_': '/tools/buildbot/bin/python'} 07:28:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:28:13 INFO - Running setup.py (path:/tmp/pip-uJ6gR9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:28:13 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)) 07:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:28:13 INFO - Running setup.py (path:/tmp/pip-caNUbq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:28:13 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)) 07:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:28:13 INFO - Running setup.py (path:/tmp/pip-BrKVcS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:28:13 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)) 07:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:28:13 INFO - Running setup.py (path:/tmp/pip-ZzV9Vi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:28:13 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)) 07:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:28:13 INFO - Running setup.py (path:/tmp/pip-Nj5Xak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:28:13 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)) 07:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:28:13 INFO - Running setup.py (path:/tmp/pip-140rhw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:28:13 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)) 07:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:28:13 INFO - Running setup.py (path:/tmp/pip-Gj2i0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:28:13 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)) 07:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:28:13 INFO - Running setup.py (path:/tmp/pip-indJwe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:28:13 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)) 07:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:28:13 INFO - Running setup.py (path:/tmp/pip-GBLOKw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:28:13 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)) 07:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:28:13 INFO - Running setup.py (path:/tmp/pip-fsCQB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:28:13 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)) 07:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:28:13 INFO - Running setup.py (path:/tmp/pip-thq1Zl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:28:13 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)) 07:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:28:13 INFO - Running setup.py (path:/tmp/pip-L2EvIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:28:13 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)) 07:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:28:13 INFO - Running setup.py (path:/tmp/pip-le4Ugj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:28:14 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)) 07:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:28:14 INFO - Running setup.py (path:/tmp/pip-P5XOgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:28:14 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)) 07:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:28:14 INFO - Running setup.py (path:/tmp/pip-VBXGws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:28:14 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)) 07:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:28:14 INFO - Running setup.py (path:/tmp/pip-bbg31Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:28:14 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)) 07:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:28:14 INFO - Running setup.py (path:/tmp/pip-u5ceVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:28:14 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)) 07:28:14 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)) 07:28:14 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)) 07:28:14 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)) 07:28:14 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)) 07:28:14 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)) 07:28:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:28:14 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 07:28:14 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 07:28:14 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 07:28:14 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 07:28:14 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 07:28:14 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 07:28:16 INFO - Downloading blessings-1.6.tar.gz 07:28:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:28:16 INFO - Installing collected packages: blessings 07:28:16 INFO - Running setup.py install for blessings 07:28:16 INFO - Successfully installed blessings 07:28:16 INFO - Cleaning up... 07:28:16 INFO - Return code: 0 07:28:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:28:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:28:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:28:16 INFO - Reading from file tmpfile_stdout 07:28:16 INFO - Current package versions: 07:28:16 INFO - argparse == 1.2.1 07:28:16 INFO - blessings == 1.6 07:28:16 INFO - blobuploader == 1.2.4 07:28:16 INFO - docopt == 0.6.1 07:28:16 INFO - manifestparser == 1.1 07:28:16 INFO - mozInstall == 1.12 07:28:16 INFO - mozcrash == 0.17 07:28:16 INFO - mozdebug == 0.1 07:28:16 INFO - mozdevice == 0.48 07:28:16 INFO - mozfile == 1.2 07:28:16 INFO - mozhttpd == 0.7 07:28:16 INFO - mozinfo == 0.9 07:28:16 INFO - mozleak == 0.1 07:28:16 INFO - mozlog == 3.1 07:28:16 INFO - moznetwork == 0.27 07:28:16 INFO - mozprocess == 0.22 07:28:16 INFO - mozprofile == 0.28 07:28:16 INFO - mozrunner == 6.11 07:28:16 INFO - mozscreenshot == 0.1 07:28:16 INFO - mozsystemmonitor == 0.0 07:28:16 INFO - moztest == 0.7 07:28:16 INFO - mozversion == 1.4 07:28:16 INFO - psutil == 3.1.1 07:28:16 INFO - requests == 1.2.3 07:28:16 INFO - wsgiref == 0.1.2 07:28:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:28:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:16 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 0x7f607976ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22567d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e5640>, '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 0x22e6540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e69d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1460989303.68382-256540036', '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 07:28:16 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 07:28:16 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 07:28:16 INFO - Using env: {'DISPLAY': ':0', 07:28:16 INFO - 'HOME': '/home/cltbld', 07:28:16 INFO - 'LANG': 'en_US.UTF-8', 07:28:16 INFO - 'LANGUAGE': 'en_US:en', 07:28:16 INFO - 'LOGNAME': 'cltbld', 07:28:16 INFO - 'MAIL': '/var/mail/cltbld', 07:28:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:16 INFO - 'MOZ_NO_REMOTE': '1', 07:28:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:16 INFO - 'NO_EM_RESTART': '1', 07:28:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:16 INFO - 'PWD': '/builds/slave/test', 07:28:16 INFO - 'SHELL': '/bin/bash', 07:28:16 INFO - 'SHLVL': '1', 07:28:16 INFO - 'TERM': 'linux', 07:28:16 INFO - 'TMOUT': '86400', 07:28:16 INFO - 'USER': 'cltbld', 07:28:16 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1460989303.68382-256540036', 07:28:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:16 INFO - '_': '/tools/buildbot/bin/python'} 07:28:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:16 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)) 07:28:16 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)) 07:28:16 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)) 07:28:16 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)) 07:28:16 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)) 07:28:16 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)) 07:28:16 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)) 07:28:16 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)) 07:28:16 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)) 07:28:16 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)) 07:28:16 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)) 07:28:16 INFO - Cleaning up... 07:28:16 INFO - Return code: 0 07:28:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:28:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f607976ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22567d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e5640>, '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 0x22e6540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e69d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1460989303.68382-256540036', '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 07:28:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:28:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:28:16 INFO - Using env: {'DISPLAY': ':0', 07:28:16 INFO - 'HOME': '/home/cltbld', 07:28:16 INFO - 'LANG': 'en_US.UTF-8', 07:28:16 INFO - 'LANGUAGE': 'en_US:en', 07:28:16 INFO - 'LOGNAME': 'cltbld', 07:28:16 INFO - 'MAIL': '/var/mail/cltbld', 07:28:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:16 INFO - 'MOZ_NO_REMOTE': '1', 07:28:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:16 INFO - 'NO_EM_RESTART': '1', 07:28:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:16 INFO - 'PWD': '/builds/slave/test', 07:28:16 INFO - 'SHELL': '/bin/bash', 07:28:16 INFO - 'SHLVL': '1', 07:28:16 INFO - 'TERM': 'linux', 07:28:16 INFO - 'TMOUT': '86400', 07:28:16 INFO - 'USER': 'cltbld', 07:28:16 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1460989303.68382-256540036', 07:28:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:16 INFO - '_': '/tools/buildbot/bin/python'} 07:28:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:17 INFO - Downloading/unpacking jsonschema 07:28: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 07:28: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 07:28: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 07:28: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 07:28: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 07:28: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 07:28:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:28:18 INFO - Downloading/unpacking functools32 (from jsonschema) 07:28: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 07:28: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 07:28: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 07:28: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 07:28: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 07:28: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 07:28:19 INFO - Downloading functools32-3.2.3-2.tar.gz 07:28:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:28:19 INFO - warning: no files found matching '*.txt' 07:28:19 INFO - no previously-included directories found matching 'build' 07:28:19 INFO - no previously-included directories found matching 'dist' 07:28:19 INFO - no previously-included directories found matching '.git*' 07:28:19 INFO - Installing collected packages: jsonschema, functools32 07:28:19 INFO - Running setup.py install for functools32 07:28:19 INFO - warning: no files found matching '*.txt' 07:28:19 INFO - no previously-included directories found matching 'build' 07:28:19 INFO - no previously-included directories found matching 'dist' 07:28:19 INFO - no previously-included directories found matching '.git*' 07:28:19 INFO - Successfully installed jsonschema functools32 07:28:19 INFO - Cleaning up... 07:28:19 INFO - Return code: 0 07:28:19 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:28:19 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')]} 07:28:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:19 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')]} 07:28:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:19 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 0x7f607976ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22567d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e5640>, '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 0x22e6540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e69d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1460989303.68382-256540036', '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 07:28:19 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 07:28:19 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 07:28:19 INFO - Using env: {'DISPLAY': ':0', 07:28:19 INFO - 'HOME': '/home/cltbld', 07:28:19 INFO - 'LANG': 'en_US.UTF-8', 07:28:19 INFO - 'LANGUAGE': 'en_US:en', 07:28:19 INFO - 'LOGNAME': 'cltbld', 07:28:19 INFO - 'MAIL': '/var/mail/cltbld', 07:28:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:19 INFO - 'MOZ_NO_REMOTE': '1', 07:28:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:19 INFO - 'NO_EM_RESTART': '1', 07:28:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:19 INFO - 'PWD': '/builds/slave/test', 07:28:19 INFO - 'SHELL': '/bin/bash', 07:28:19 INFO - 'SHLVL': '1', 07:28:19 INFO - 'TERM': 'linux', 07:28:19 INFO - 'TMOUT': '86400', 07:28:19 INFO - 'USER': 'cltbld', 07:28:19 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1460989303.68382-256540036', 07:28:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:19 INFO - '_': '/tools/buildbot/bin/python'} 07:28:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:19 INFO - Downloading/unpacking flake8 07:28:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:28:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:28:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:28:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:28:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:28:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:28:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:28:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:28:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:28:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:28:22 INFO - no previously-included directories found matching 'docs/_build' 07:28:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:28:22 INFO - Running setup.py install for pep8 07:28:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:28:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:28:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:28:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:28:22 INFO - no previously-included directories found matching 'docs/_build' 07:28:22 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:28:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:28:22 INFO - Cleaning up... 07:28:22 INFO - Return code: 0 07:28:22 INFO - Running post-action listener: _resource_record_post_action 07:28:22 INFO - Running post-action listener: _start_resource_monitoring 07:28:22 INFO - Starting resource monitoring. 07:28:22 INFO - ##### 07:28:22 INFO - ##### Running install step. 07:28:22 INFO - ##### 07:28:22 INFO - Running pre-action listener: _resource_record_pre_action 07:28:22 INFO - Running main action method: install 07:28:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:28:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:28:22 INFO - Reading from file tmpfile_stdout 07:28:22 INFO - Detecting whether we're running mozinstall >=1.0... 07:28:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:28:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:28:22 INFO - Reading from file tmpfile_stdout 07:28:22 INFO - Output received: 07:28:22 INFO - Usage: mozinstall [options] installer 07:28:22 INFO - Options: 07:28:22 INFO - -h, --help show this help message and exit 07:28:22 INFO - -d DEST, --destination=DEST 07:28:22 INFO - Directory to install application into. [default: 07:28:22 INFO - "/builds/slave/test"] 07:28:22 INFO - --app=APP Application being installed. [default: firefox] 07:28:22 INFO - mkdir: /builds/slave/test/build/application 07:28:22 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'] 07:28:22 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 07:28:38 INFO - Reading from file tmpfile_stdout 07:28:38 INFO - Output received: 07:28:38 INFO - /builds/slave/test/build/application/firefox/firefox 07:28:38 INFO - Running post-action listener: _resource_record_post_action 07:28:38 INFO - ##### 07:28:38 INFO - ##### Running run-tests step. 07:28:38 INFO - ##### 07:28:38 INFO - Running pre-action listener: _resource_record_pre_action 07:28:38 INFO - Running main action method: run_tests 07:28:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:28:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:28:38 INFO - Python 2.7.3 07:28:38 INFO - Return code: 0 07:28:38 INFO - grabbing minidump binary from tooltool 07:28:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:38 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 0x22e5640>, '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 0x22e6540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e69d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:28:38 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 07:28:38 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 07:28:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:28:38 INFO - Return code: 0 07:28:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:28:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:28:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:28:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:28:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:28:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:28:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:28:39 INFO - Return code: 0 07:28:39 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T4QvblmPSfiRuWEIfeMGXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:28:39 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/T4QvblmPSfiRuWEIfeMGXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:28:39 INFO - Using env: {'DISPLAY': ':0', 07:28:39 INFO - 'HOME': '/home/cltbld', 07:28:39 INFO - 'LANG': 'en_US.UTF-8', 07:28:39 INFO - 'LANGUAGE': 'en_US:en', 07:28:39 INFO - 'LOGNAME': 'cltbld', 07:28:39 INFO - 'MAIL': '/var/mail/cltbld', 07:28:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:28:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:28:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:39 INFO - 'MOZ_NO_REMOTE': '1', 07:28:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:28:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:28:39 INFO - 'NO_EM_RESTART': '1', 07:28:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:28:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:39 INFO - 'PWD': '/builds/slave/test', 07:28:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:28:39 INFO - 'SHELL': '/bin/bash', 07:28:39 INFO - 'SHLVL': '1', 07:28:39 INFO - 'TERM': 'linux', 07:28:39 INFO - 'TMOUT': '86400', 07:28:39 INFO - 'USER': 'cltbld', 07:28:39 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1460989303.68382-256540036', 07:28:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:39 INFO - '_': '/tools/buildbot/bin/python'} 07:28:39 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T4QvblmPSfiRuWEIfeMGXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:28:39 INFO - mozversion application_buildid: 20160418061615 07:28:39 INFO - mozversion application_changeset: 1306c789088d5675435586edf04b9a2b70f86dec 07:28:39 INFO - mozversion application_display_name: Nightly 07:28:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:28:39 INFO - mozversion application_name: Firefox 07:28:39 INFO - mozversion application_remotingname: firefox 07:28:39 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:28:39 INFO - mozversion application_vendor: Mozilla 07:28:39 INFO - mozversion application_version: 48.0a1 07:28:39 INFO - mozversion platform_buildid: 20160418061615 07:28:39 INFO - mozversion platform_changeset: 1306c789088d5675435586edf04b9a2b70f86dec 07:28:39 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:28:39 INFO - mozversion platform_version: 48.0a1 07:28:39 INFO - using testdate: 1460989719 07:28:39 INFO - actual date: 1460989719 07:28:39 INFO - starting webserver on 'localhost:40248' 07:28:39 INFO - SUITE-START | Running 2 tests 07:28:39 INFO - TEST-START | dromaeo_css 07:28:39 INFO - operating with platform_type : linux_ 07:28:39 INFO - Initialising browser for dromaeo_css test... 07:28:39 INFO - TEST-INFO | started process 14008 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcvK4f1/profile http://localhost:40248/getInfo.html) 07:28:43 INFO - PROCESS | 14008 | 07:28:43 INFO - PROCESS | 14008 | (process:14076): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:28:44 INFO - PROCESS | 14008 | __metrics Screen width/height:1600/1200 07:28:44 INFO - PROCESS | 14008 | colorDepth:24 07:28:44 INFO - PROCESS | 14008 | Browser inner width/height: 1024/697 07:28:44 INFO - PROCESS | 14008 | __metrics 07:28:44 ERROR - PROCESS | 14008 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 07:28:45 INFO - TEST-INFO | 14008: exit 0 07:28:45 INFO - Browser initialized. 07:28:45 INFO - Running cycle 1/1 for dromaeo_css test... 07:28:45 INFO - TEST-INFO | started process 14127 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcvK4f1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:28:47 INFO - PROCESS | 14127 | 07:28:47 INFO - PROCESS | 14127 | (process:14186): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:28:57 INFO - PROCESS | 14127 | RSS: Main: 164925440 07:28:57 INFO - PROCESS | 14127 | 07:29:46 INFO - PROCESS | 14127 | 1460989786909 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] 07:31:58 INFO - PROCESS | 14127 | Cycle 1(1): loaded http://localhost:40248/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40248/tests/dromaeo/cssquery-ext.html) 07:31:59 INFO - PROCESS | 14127 | RSS: Main: 169562112 07:31:59 INFO - PROCESS | 14127 | 07:35:01 INFO - PROCESS | 14127 | Cycle 1(1): loaded http://localhost:40248/tests/dromaeo/cssquery-ext.html (next: http://localhost:40248/tests/dromaeo/cssquery-jquery.html) 07:35:02 INFO - PROCESS | 14127 | RSS: Main: 165974016 07:35:02 INFO - PROCESS | 14127 | 07:38:04 INFO - PROCESS | 14127 | Cycle 1(1): loaded http://localhost:40248/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40248/tests/dromaeo/cssquery-mootools.html) 07:38:04 INFO - PROCESS | 14127 | RSS: Main: 166617088 07:38:04 INFO - PROCESS | 14127 | 07:41:06 INFO - PROCESS | 14127 | Cycle 1(1): loaded http://localhost:40248/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40248/tests/dromaeo/cssquery-prototype.html) 07:41:07 INFO - PROCESS | 14127 | RSS: Main: 164454400 07:41:07 INFO - PROCESS | 14127 | 07:44:09 INFO - PROCESS | 14127 | Cycle 1(1): loaded http://localhost:40248/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40248/tests/dromaeo/cssquery-yui.html) 07:44:10 INFO - PROCESS | 14127 | RSS: Main: 165552128 07:44:10 INFO - PROCESS | 14127 | 07:47:12 INFO - PROCESS | 14127 | Cycle 1(1): loaded http://localhost:40248/tests/dromaeo/cssquery-yui.html (next: http://localhost:40248/tests/dromaeo/cssquery-dojo.html) 07:47:12 INFO - PROCESS | 14127 | RSS: Main: 167649280 07:47:12 INFO - PROCESS | 14127 | 07:47:12 INFO - PROCESS | 14127 | __start_tp_report 07:47:12 INFO - PROCESS | 14127 | _x_x_mozilla_page_load 07:47:12 INFO - PROCESS | 14127 | _x_x_mozilla_page_load_details 07:47:12 INFO - PROCESS | 14127 | |i|pagename|runs| 07:47:12 INFO - PROCESS | 14127 | |0;dojo.html;2621.960670589941;2695.743904329088;2727.2909043648656;2730.890764369425;2739.0687166363446;4791.568758811706;4794.280857871321;4820.807167713296;4847.515248475155;4901.166801643721;4723;4796.640251981106;4810.182269014267;4850.1027309947685;4873.415190177175;4406.118776244748;4429.64562834974;4490.842820501283;4506.639468842484;4517.186906356855;4419.823207071713;4540.046590216059;4543.704659197158;4573.748443835588;4581.793819278124;4260.1905637929;4288.120935208306;4356.869293921188;4457.974665826846;4503.572160644766;4321.222180007598;4354.54277300882;4357.9782101089295;4388.692791504596;4405.449318835145;4339.7830108494445;4367.716098453622;4374.409454723604;4384.123175364908;4430.534793846632;4642.721436713808;4656.394668693082;4699.765011749433;4701.318308845232;4738.526147385269;5007.424146223195;5036.470308411952;5046.21783623539;5068.695878247317;5095.515925987025;4988.975055124737;5087.618428617869;5105.030044291572;5113.769880355356;5155.587552995751;4784.091022705709;4843.588294994965;4854.19905715553;4857.0528746894015;4907.55831975124;5209.869753256123;5213.504717051874;5221.765020574007;5243.947560524422;5308.814191503279;4854.101991131652;4951.059298733229;4998.675086119463;5005.549500544968;5031.622628302892;5102.668326558762;5118.053160165381;5134.845954621367;5149;5187.922181167285;4915.827946021872;5095.439501654815;5123.257127716534;5146.819861304836;5186.714730689849;4935.383077115361;5005.998800239967;5039.21892106724;5049.469805670426;5113.054084994214;4280.250956082673;4322.481302243751;4337.15425492026;4338.891527711769;4382.320740285261;3762.435634654824;3763.7741735495956;3774.6036666149657;3813.1420430402936;3824.6175382461533;4297.269464191095;4360.258756011485;4421.977890110529;4433.334999749999;4507.887302817456;5126;5139.511746384088;5139.717315547681;5148.0476111919415;5169.7932082717025;4475.619572336388;4479.3057076153245;4482.125985432809;4487.730736155841;4523.773811309421;4496.303073023687;4566.657500687462;4665.95334046662;4670.509596492388;4687.062587482449;4816.34979277807;4821.975890120527;4823.614110871122;4834.540718631724;4852.0295940811275;5130.050940576006;5154.098032844312;5166.405863325615;5169.638125331341;5225.947740522546;4716.952830471651;4856.951430485791;4895.902081958412;4906.607471402351;4943.258511223202;5056.57019153376;5061.987602479445;5063.87340316495;5074.644774865724;5131.435542090292;4972.453030166751;5142.1258386073705;5150.742462876766;5151.459096794782;5156.381234251914;4885.731284779371;4935.555799978019;4937.703737775745;4939.802407903788;4999.525045120708;4931.137051015986;4953.009398120463;4979.0788704089855;4985.52637499437;5018.84943451697;4840.031993601224;4889.951100489092;4891.877703057452;4894.755262236945;4941.283513890394;4880.194767863263;5027.773750181177;5035.118854200574;5112.948870511247;5117;4823.324734537097;4840;4856.684315519621;4857.781399837087;4864.73243971585 07:47:12 INFO - PROCESS | 14127 | |1;ext.html;581.6917033971996;603.3453702732535;614.6158650843223;617.3271134463436;642.7718160053178;33151.83424082879;34473;34488.82755586225;34498.827505862464;34532.30935381294;34233.65766342336;34707.82646086772;34865.12837179072;34927.82536087323;35048.29903401931;7408.96295518523;7626.961865190667;7627;7637.732679356196;7650.120236172856;7418.072740907387;7686.231376862297;7701.037370328709;7717.575533345664;7745.457817952745;7706.383489320869;7773.689052437896;7779.727709530168;7779.805504862367;7789.143194248628;7692.4999875008225;7713.884291735629;7714.575698336589;7735.690572377098;7750.263724946121;7654.158042615308;7687.577183254919;7759.418043646749;7789.649465773997;7789.961050194769;29278.560821587693;34755.47866782;35374.823125884206;35409.64590354089;35431;2755.931101722453;2856.6286382770313;2856.8428736419696;2903.9274018149504;2974.4794660934467;27472.725272747215;27727.445451090865;27800.165995020183;28363.149105526867;28920.26478411302;3477.2697733476;3482.6517348265224;3500.2824420993634;3517.1734642359024;3531.29374125176;191094;195016;196066;196249;196649;55966.72016639891;57250.71374643184;57270.42729572651;57294.427055728906;57356.71321643365;62501.687491562254;64509;64685.67657161778;64777.35222647808;64947.35052649413;13385.93307033478;13496;13503.12229705066;13527.32363381827;13571.728565428637;9564.904350956402;9666.033396660418;9674.661386851427;9754.365966212174;9848.852267215998;19499.415017549498;19734.30929917446;19745.308914187935;19812.603747925248;19837.80973141616;7544.962275188589;7758.198482743528;7825.37397008238;7943.24539168778;7984.4810087345295;874.6239117179674;952.6713283917038;973.9432715503616;975.512243878061;994.2940512236248;27369;27635;28733.425331493254;28814.135575932756;28835.85582072076;975.7219192530094;1008.6520150548049;1045.0333441566672;1056.4506456642503;1061.5435362794074;14427.855721442862;15192.924035379974;15205.31576079079;15438;15472.226388680521;337476;342006;345673;347436;347509;48297.27554086692;48463.51536484661;49054.26418603724;49331.75334123307;49488;1201.1711918776016;1228.7603917236231;1240.8200810882552;1249.443997421157;1255.7802384582662;26089;27196.864015679796;27752;27972.860135700004;29148.854255728587;46898.76550617225;47864.282035770186;48115;48157.27764083471;48215.75892120517;322660;327000;327639;328554;331452;38468.23063538658;38751;39109;39597.20805583814;40071.799641001606;42347.7882610585;42366.57633423626;42994.57005429906;43336.783316083216;43448.56551434445;36544.0863978392;36609;36913.630863692095;36972.26055478821;37177.070573235884;35720.82139589285;36930.44604330991;36948.815255923546;37117.443238350905;37653.435198472594;35783;36035.63964360323;36049.63950360568;36554.268914621025;37234;32542.83728581342;33010.66989330172;33246.00315579559;33311.50032749462;33886.491702624975;25274.873625631753;25368.238952831445;25664.743352566235;26182.60726089072;26525.86737066302 07:47:12 INFO - PROCESS | 14127 | |2;jquery.html;380.94476300936367;383.9328117579424;390.95699473057965;395.60637166019814;401.7248184993278;14941.402343906244;16911.49265522036;17534.82465175348;17725.82274177258;17761.555961100978;16395.91802040988;17042.65914681709;17289.654206915853;17301.22144503497;17379.47861564152;5000.424951130612;5189.117849965496;5192.039472697544;5213.687178769267;5220.112580861243;3693.1321139532324;5632.7183640818;5909.852253693649;5918.585699001072;5949.6727679977585;5634.32388113427;5873;5881.852953676171;5898;5905.025670764318;5798.478136967672;5852.970735146339;5894.2926848778425;5895.587308888358;5916.704164791765;5024.572911302544;5122.290952117077;5130.30740849988;5186.403563590197;5189.1956746703945;20393.796062039488;20415.693764593394;20612.484687882774;20805.687914681293;20831.791682083287;1962.3426152239017;2005.1678553400322;2008.1465377214624;2103.82117520011;2230.9291540060863;12963.67590810228;13220.272884991322;13363.331833408389;13495.86504134956;13534.932325338408;1666.5666926599172;1784.1881943715578;1807.8644101692425;1847.0303090877262;1887.8867267963967;66843.3315666842;68392;68741.65629171873;68818.65590672015;69114.65442672804;9157.679481218125;9330.766730831649;9638;9781.510924453749;9864.457454840052;13614;13633.659158521117;13681.726365472634;13706.65733356674;13723.862761372458;6849.589024658537;6890.069840571458;6899.448044156556;7006.4745144114395;7072.575645461289;6393.424591786761;6511.186101737283;6599.769008084694;6619.271880093186;6656;5943.881122377615;6125.264968203844;6139.6009259398;6189.731105123529;6190.845228869224;1597.6565038516774;1690.8309169082993;1783.2599471219557;1809.9457016289532;1838.1820090060062;898.9775255618662;946.0161432110528;972.3145182646217;973.5132433783108;998.5306905754284;16304.266308016167;16680.666386672197;16885.40901068457;17000.82999170017;17030.318787248372;868.6221493650282;872.1757938747949;892.2594246775161;902.3999040637902;939.5067589515559;9604.279679024101;9669.806603868024;9702.6118955241;9802.607895684092;9812.018798120274;440519;442247;447421;457157;471596;82328.58835705783;84977.15022849692;86278.56860715656;86955;87576;933.5518950903469;977.0522593084696;978.114806100466;984.8227319082633;989.2382865193904;15417.306221220297;15451.768223476432;15560.766588500956;15626.45307414235;15936.840631593535;34949;35431.64568354283;36572;36601.63398366089;36727;45285;47597;49429.25856112089;51559;51995.74002129965;7629.656665450179;7646.885296720665;7751.728689495841;7793.64928578204;7839.25527074927;8484.321254299517;10871.273537515817;11664;11784.58753943608;12026.939865300617;10104.747381315232;10110.747231319276;10421.895781042092;10577.259591828499;10586.8941310589;9997.500124993867;10526.473676316;10645.414502202453;10670.57317707314;10820.350778953289;10387.272890897564;10484.63303784364;10505.474726263808;10728.088112510524;10835.837462437912;7811.1017233016655;7842.882356764539;7860.788770586693;7879.369650428067;7978.361731061617;7348.889766653398;8395;9400.76498087526;9461.668841590512;9556.617735290789 07:47:12 INFO - PROCESS | 14127 | |3;mootools.html;1404.84546699863;1464.1727424005437;1592.8805339599526;1779.9644007119866;1821.8542516598673;6746.797596072113;7288.708451661933;7601.505902116359;7602.315791578763;7631.236876312366;7666.501677390966;7685.846283074336;7746.457747957646;7749.147593764681;7753.457257991929;2190.3647942096773;2213.214308920334;2217.866927984326;2219.1012639880873;2232.6092933736613;2160;2198.076807740753;2208.5803697297542;2209.4476380904775;2210.613142700029;2166.6425039868404;2189.9890500547476;2191.9452013699706;2195.473086459246;2197.813185879202;2110.862793918398;2115.9894200528975;2116.7354080739906;2118.7245658064508;2121.628714974873;2065.1429656692453;2152.7416709994745;2174.913003479859;2180.7819218078225;2180.967285490719;7836.568988705619;7889.1716369780925;7889.566073865935;7939.801504962365;7958.045034595828;4746.21687421575;4940.1601727706375;4958.528939750718;4972.7513624319;4975.4029516457895;2821.957670634942;2847.9145625631263;2945.2784067903285;2983.74638155757;3006.879724811005;847.8728190771373;865.7489328094845;867.9609417576224;868.8653258744905;883.6112110671284;10736.624218152405;10736.73158171052;10774.084202842767;10785;10786.946065269702;4312.331588603772;4328.458942632171;4487.483939346952;4535.478419981679;4560.543945605413;7808.57052862098;7878.290953814184;7886.487378320391;7933.722319718782;7940.920590794018;4551.067031258584;4566.748828814447;4568;4569.040501494724;4573.108243892476;3730.477733117366;4162.084341444877;4195.412642230091;4263;4358.171947329997;3538.9469157962653;3633.255182687543;3640.43573246142;3681.079730067483;3792.393217085253;1083.1876092930302;1092.317301686446;1093.5516438260274;1097.0894157848966;1101.4767985206963;865.913408659129;873.0963452826294;874.1477059866706;878.508035500122;895.136193573205;5410.269613602192;5509.862253443696;5523.558115350762;5645.463680950304;5712.857178570569;953.2564599612314;954.8376775948105;992.717075633441;1000.9299349045497;1013.4020927652573;3658.817059147032;3721.5906250312987;3843.2121415109837;3906.882793516199;3919.2161567686576;9383.859242111374;9759.560819763128;9807.558659860324;9850.359726617748;9857.35927164732;9711.757206069904;9721.270904682036;9744.366616169926;9802.901970980342;9816.116549510578;7370.926290737131;7391.704331826667;7452.5528468290995;7462.253774622603;7463.216362281991;5441.0478166319945;5477.726113694379;5510.090835012178;5629.521490673174;5764.13537969308;8872.512011839412;8955.194032537103;9070.455772653662;9072.727818165466;9173.587188576663;8529.91470085316;8874.156955089256;8960.775980600276;8975.730728078168;8987.191152796018;6045.425684559959;6472.35276472349;6644.368784965421;6775.966120169368;6958.060661810793;7356.374708149653;7397.186309506058;7421.740239091606;7425.257474252531;7480.364169045474;6622.735090596322;6783.389494945479;6817.181938167451;6827.590344579341;6899.48253880971;6548.770793022221;6599.0761293418;6603.108580341785;6624.039514270307;6663.800085997428;6456.935430645822;6466.353364663684;6488.156539649815;6516.413522782972;6558.672066396565;4828.396450443694;4852.344933434082;4885.047415753894;4905.298418078569;4955.231939049453;4738.928916066331;4761.452432970253;4806.375171227718;4827.25177597473;4873.537013983666 07:47:12 INFO - PROCESS | 14127 | |4;prototype.html;311.3850145961726;312.32537718527976;312.8983080498837;318.1854452601341;320.47122248290333;5350.732463376826;5362.1420572708375;5377.7580008899595;5398.271233383487;5421.268128802611;5297.3713006590515;5308.867278318044;5312.1766126250495;5313;5318.282031925689;3924.4113382992496;3996.561237954334;4163.50037995441;4171.457710497646;4191.664666826662;4132.524759652633;4159.147374788161;4164;4164.917960709068;4172.70791044627;4108.26051310764;4132;4143.254214241435;4157.355609880458;4162.562930892258;4031.395290706388;4107.342825147992;4133.813978370966;4142.91714165718;4164.12553363794;3600.9099772505633;3612.151144481045;3636.890893273206;3639.3631114554846;3660.5424321959754;5100.846974590768;5101.260317254015;5113.488651134894;5123.897522049576;5173.586113110942;4605.125026245003;4786;4795.112904112751;4799.352087468182;4821.252705830567;5641.464060914206;5643.492085712305;5657.773689052433;5668.546516278688;5671.914921276184;3993.6206060424215;4019.135885784541;4028.2950483665536;4041.838326466938;4046.8381264749373;5634.690092044936;5832.250324902512;5893.086571581412;5923.970380148072;5939.584229103964;3926.1951299983434;3952.8616498422994;3967.385055316373;3971.5035620547433;3974.0859602291634;4025.7987100645437;4034.7175697700877;4043.130726893673;4046.2109888572036;4051.8987025324604;4567.1550763108935;4641.930371044437;4656.650751193674;4663.673542851968;4671.883202919887;5584.078627026495;5653.689047102449;5673.687947162945;5676.091825307931;5679.630823996427;1404.9157050576998;1426.721789251086;1428.3787900732743;1432.584550480349;1433.806436131109;874.2394117118148;906.4470672889532;932.48247222792;946.9005754395827;948.9182332141364;4738.455077666113;4762.928556071662;4783.115123702126;4794.712317260975;4820.421549414093;5693.800716974969;5695.316562012502;5717.085266357363;5729.455701708331;5733.541316694655;4675.13510000651;4748;4775.283707443842;4810.6151507879285;4823.300621409946;3055.297281625194;3068.647105582842;3081.4145312390574;3083.92290192747;3096.674849140853;5378.542823860016;5387.542058925035;5388.763663079856;5389.784408623689;5406.351237851483;5681.897697851821;5845;5865.445656900924;5895.204147440127;5904.468597826216;5234.476552344811;5264.89470210586;5356.839294821161;5372.140457526777;5382.354117505846;5493.148561972901;5630.549556035589;5686.60193786431;5687.118496633028;5694;5510.768138903751;5578.665280083208;5598.944010559842;5607.5513958884;5608.551315894637;5339.893202136013;5352.143657014859;5371.274877891435;5372.892542149057;5386.8383948481605;3793.165503589206;3965.2267807777207;3975.5030621172355;3975.747639493666;3987.0431096537204;5744.253247077853;5783.479486846036;5804.187413762161;5805.941940580709;5816.796412125725;5580.665160090245;5591.862022103695;5601.467860553241;5633.2395126657375;5647.29408823897;5290.65610735301;5624.6625202487985;5645.633033852787;5664.546836253007;5675.177099320658;5210.765515551733;5525.419830917695;5566.582506312124;5569.164625306236;5569.8024924641395;5441.347038355423;5622.18478320633;5645.463680950304;5646.181303711021;5681.147827825859;5506.972465137809;5515.972420137874;5519.199716041232;5545.694986775766;5574.665520068809 07:47:12 INFO - PROCESS | 14127 | |5;yui.html;722.7181399254292;742.7736181129374;761.094297785635;766.877299632059;775.0505630602516;11013.944930275347;11248.325100493967;12032.639020829367;12058.879411205886;12061.879381206185;11640.825387619172;11738.530458781639;11741.119416043788;11769.588064417747;11798.351090690008;645.0678769178539;795.6658203554521;805.8791181322819;822.1696086952162;822.268181318627;816.1878930464196;820.5035953248289;821.3552361396305;821.4167940762067;826.7519744076783;849.2441726863096;854.0306751836679;854.4189950833431;854.5940678177847;855.7860534866284;835.3108685334593;843.2537204573935;845.6321500147455;848.0628905059882;849.5370023337265;615.1449485215554;618.2086928731231;618.7555915413386;618.8886000519905;619.2692622705206;12053.15627906047;12098.092643051807;12100.697482563006;12100.697482563006;12126.636200913987;12862.871371286261;12955.740885182244;12983.285919274436;13062.34688265583;13088.214707117604;9782.608695652165;10067.29528932975;10223.233257505717;10223.335483193569;10585.523651435704;3369.898903032913;3375.0887260439545;3376.1053320869987;3405.387030334539;3424.931501369959;47481;47881.521184788406;48003.51996480025;48327.75836120832;49549.752251238875;9942.701718948443;9976.501174941224;9986.750331241778;10119.544620492095;10155.949220253851;16430.6713865722;16641.916790416213;16684.74972875408;16707.83292167087;16742;6720.697568609425;6767.154105736783;6798.592084474848;6890;6962.373386395248;3687.1519550503535;3770.816812053969;3771;3807.371783655721;3822.8853134406013;2799.440111977572;2898.594196812448;2911.694272101441;2916.8104073235595;2918.1829087855435;547.8739889825363;568.6815383385317;572.9627574207747;581.9621724587888;582.3943099176894;488.5676176583678;600.354618784808;610.8533951851613;617.7621615677996;652.9608223506605;7513.586752728653;7897.60511974399;8017.158198389086;8298.128696486903;8387.790305242417;493.1788572027534;603.9547033972382;637.1366797988659;642.322349920838;647.346180357842;3586.1751797086818;3935.370340745467;3943.38877473992;3959.7228194026143;4007.757595145514;49028.509714903106;50282;52255.73872130615;52911.73544132255;53130;44699.329510057374;45409;45528.77235613867;45601.77199114049;45856.77071614687;40431.59568404278;42067.7896610515;42119.36820947688;42392.15215695669;43055.1388972225;7704.92295077042;7712.421568382281;7873.881891771743;7912.32745216663;8077.434579579608;27015;27232.455350893266;27454.725452745217;27768.722312777423;27900.86049569739;37125.814370927976;38216.23567528578;38522.422163667004;38539.807300963315;39117.608823911396;9200.815983680423;9330;9468.755303960756;9523.809523809347;9632.807343852943;10128.949355253177;10162.23783216247;10205.693829185137;10601.204909631655;10715.464226788474;10067;10096.242781791541;10132.290739648153;10150.593976240867;10342.224333174892;9458;9692.176165026052;9726.902730972599;9820.508974551101;9829.754256143653;9686.418814871131;9921.0497496093;9974.750631234278;9978.351407158512;10016;8524.74425767228;8662.696805611773;8682.43564168327;8935.195832375117;9009.279257659502;8825.955870220609;8887.37788354809;8903.688370906988;8951.865722014305;9063.909360906306 07:47:12 INFO - PROCESS | 14127 | __end_tp_report 07:47:12 INFO - PROCESS | 14127 | __start_cc_report 07:47:12 INFO - PROCESS | 14127 | _x_x_mozilla_cycle_collect,364 07:47:12 INFO - PROCESS | 14127 | __end_cc_report 07:47:12 INFO - PROCESS | 14127 | __startTimestamp1460990832955__endTimestamp 07:47:12 INFO - PROCESS | 14127 | 07:47:12 INFO - PROCESS | 14127 | ------- Summary: start ------- 07:47:12 INFO - PROCESS | 14127 | Number of tests: 6 07:47:12 INFO - PROCESS | 14127 | 07:47:12 INFO - PROCESS | 14127 | [#0] dojo.html Cycles:165 Average:4731.22 Median:4856.95 stddev:486.81 (10.0%) stddev-sans-first:459.32 07:47:12 INFO - PROCESS | 14127 | Values: 2622.0 2695.7 2727.3 2730.9 2739.1 4791.6 4794.3 4820.8 4847.5 4901.2 4723.0 4796.6 4810.2 4850.1 4873.4 4406.1 4429.6 4490.8 4506.6 4517.2 4419.8 4540.0 4543.7 4573.7 4581.8 4260.2 4288.1 4356.9 4458.0 4503.6 4321.2 4354.5 4358.0 4388.7 4405.4 4339.8 4367.7 4374.4 4384.1 4430.5 4642.7 4656.4 4699.8 4701.3 4738.5 5007.4 5036.5 5046.2 5068.7 5095.5 4989.0 5087.6 5105.0 5113.8 5155.6 4784.1 4843.6 4854.2 4857.1 4907.6 5209.9 5213.5 5221.8 5243.9 5308.8 4854.1 4951.1 4998.7 5005.5 5031.6 5102.7 5118.1 5134.8 5149.0 5187.9 4915.8 5095.4 5123.3 5146.8 5186.7 4935.4 5006.0 5039.2 5049.5 5113.1 4280.3 4322.5 4337.2 4338.9 4382.3 3762.4 3763.8 3774.6 3813.1 3824.6 4297.3 4360.3 4422.0 4433.3 4507.9 5126.0 5139.5 5139.7 5148.0 5169.8 4475.6 4479.3 4482.1 4487.7 4523.8 4496.3 4566.7 4666.0 4670.5 4687.1 4816.3 4822.0 4823.6 4834.5 4852.0 5130.1 5154.1 5166.4 5169.6 5225.9 4717.0 4857.0 4895.9 4906.6 4943.3 5056.6 5062.0 5063.9 5074.6 5131.4 4972.5 5142.1 5150.7 5151.5 5156.4 4885.7 4935.6 4937.7 4939.8 4999.5 4931.1 4953.0 4979.1 4985.5 5018.8 4840.0 4890.0 4891.9 4894.8 4941.3 4880.2 5027.8 5035.1 5112.9 5117.0 4823.3 4840.0 4856.7 4857.8 4864.7 07:47:12 INFO - PROCESS | 14127 | 07:47:12 INFO - PROCESS | 14127 | [#1] ext.html Cycles:180 Average:45480.24 Median:35909.32 stddev:77963.04 (217.1%) stddev-sans-first:78108.86 07:47:12 INFO - PROCESS | 14127 | Values: 581.7 603.3 614.6 617.3 642.8 33151.8 34473.0 34488.8 34498.8 34532.3 34233.7 34707.8 34865.1 34927.8 35048.3 7409.0 7627.0 7627.0 7637.7 7650.1 7418.1 7686.2 7701.0 7717.6 7745.5 7706.4 7773.7 7779.7 7779.8 7789.1 7692.5 7713.9 7714.6 7735.7 7750.3 7654.2 7687.6 7759.4 7789.6 7790.0 29278.6 34755.5 35374.8 35409.6 35431.0 2755.9 2856.6 2856.8 2903.9 2974.5 27472.7 27727.4 27800.2 28363.1 28920.3 3477.3 3482.7 3500.3 3517.2 3531.3 191094.0 195016.0 196066.0 196249.0 196649.0 55966.7 57250.7 57270.4 57294.4 57356.7 62501.7 64509.0 64685.7 64777.4 64947.4 13385.9 13496.0 13503.1 13527.3 13571.7 9564.9 9666.0 9674.7 9754.4 9848.9 19499.4 19734.3 19745.3 19812.6 19837.8 7545.0 7758.2 7825.4 7943.2 7984.5 874.6 952.7 973.9 975.5 994.3 27369.0 27635.0 28733.4 28814.1 28835.9 975.7 1008.7 1045.0 1056.5 1061.5 14427.9 15192.9 15205.3 15438.0 15472.2 337476.0 342006.0 345673.0 347436.0 347509.0 48297.3 48463.5 49054.3 49331.8 49488.0 1201.2 1228.8 1240.8 1249.4 1255.8 26089.0 27196.9 27752.0 27972.9 29148.9 46898.8 47864.3 48115.0 48157.3 48215.8 322660.0 327000.0 327639.0 328554.0 331452.0 38468.2 38751.0 39109.0 39597.2 40071.8 42347.8 42366.6 42994.6 43336.8 43448.6 36544.1 36609.0 36913.6 36972.3 37177.1 35720.8 36930.4 36948.8 37117.4 37653.4 35783.0 36035.6 36049.6 36554.3 37234.0 32542.8 33010.7 33246.0 33311.5 33886.5 25274.9 25368.2 25664.7 26182.6 26525.9 07:47:12 INFO - PROCESS | 14127 | 07:47:12 INFO - PROCESS | 14127 | [#2] jquery.html Cycles:180 Average:26307.76 Median:28344.65 stddev:74386.28 (262.4%) stddev-sans-first:74569.48 07:47:12 INFO - PROCESS | 14127 | Values: 380.9 383.9 391.0 395.6 401.7 14941.4 16911.5 17534.8 17725.8 17761.6 16395.9 17042.7 17289.7 17301.2 17379.5 5000.4 5189.1 5192.0 5213.7 5220.1 3693.1 5632.7 5909.9 5918.6 5949.7 5634.3 5873.0 5881.9 5898.0 5905.0 5798.5 5853.0 5894.3 5895.6 5916.7 5024.6 5122.3 5130.3 5186.4 5189.2 20393.8 20415.7 20612.5 20805.7 20831.8 1962.3 2005.2 2008.1 2103.8 2230.9 12963.7 13220.3 13363.3 13495.9 13534.9 1666.6 1784.2 1807.9 1847.0 1887.9 66843.3 68392.0 68741.7 68818.7 69114.7 9157.7 9330.8 9638.0 9781.5 9864.5 13614.0 13633.7 13681.7 13706.7 13723.9 6849.6 6890.1 6899.4 7006.5 7072.6 6393.4 6511.2 6599.8 6619.3 6656.0 5943.9 6125.3 6139.6 6189.7 6190.8 1597.7 1690.8 1783.3 1809.9 1838.2 899.0 946.0 972.3 973.5 998.5 16304.3 16680.7 16885.4 17000.8 17030.3 868.6 872.2 892.3 902.4 939.5 9604.3 9669.8 9702.6 9802.6 9812.0 440519.0 442247.0 447421.0 457157.0 471596.0 82328.6 84977.2 86278.6 86955.0 87576.0 933.6 977.1 978.1 984.8 989.2 15417.3 15451.8 15560.8 15626.5 15936.8 34949.0 35431.6 36572.0 36601.6 36727.0 45285.0 47597.0 49429.3 51559.0 51995.7 7629.7 7646.9 7751.7 7793.6 7839.3 8484.3 10871.3 11664.0 11784.6 12026.9 10104.7 10110.7 10421.9 10577.3 10586.9 9997.5 10526.5 10645.4 10670.6 10820.4 10387.3 10484.6 10505.5 10728.1 10835.8 7811.1 7842.9 7860.8 7879.4 7978.4 7348.9 8395.0 9400.8 9461.7 9556.6 07:47:12 INFO - PROCESS | 14127 | 07:47:12 INFO - PROCESS | 14127 | [#3] mootools.html Cycles:180 Average:5164.64 Median:5509.98 stddev:2833.11 (51.4%) stddev-sans-first:2826.97 07:47:12 INFO - PROCESS | 14127 | Values: 1404.8 1464.2 1592.9 1780.0 1821.9 6746.8 7288.7 7601.5 7602.3 7631.2 7666.5 7685.8 7746.5 7749.1 7753.5 2190.4 2213.2 2217.9 2219.1 2232.6 2160.0 2198.1 2208.6 2209.4 2210.6 2166.6 2190.0 2191.9 2195.5 2197.8 2110.9 2116.0 2116.7 2118.7 2121.6 2065.1 2152.7 2174.9 2180.8 2181.0 7836.6 7889.2 7889.6 7939.8 7958.0 4746.2 4940.2 4958.5 4972.8 4975.4 2822.0 2847.9 2945.3 2983.7 3006.9 847.9 865.7 868.0 868.9 883.6 10736.6 10736.7 10774.1 10785.0 10786.9 4312.3 4328.5 4487.5 4535.5 4560.5 7808.6 7878.3 7886.5 7933.7 7940.9 4551.1 4566.7 4568.0 4569.0 4573.1 3730.5 4162.1 4195.4 4263.0 4358.2 3538.9 3633.3 3640.4 3681.1 3792.4 1083.2 1092.3 1093.6 1097.1 1101.5 865.9 873.1 874.1 878.5 895.1 5410.3 5509.9 5523.6 5645.5 5712.9 953.3 954.8 992.7 1000.9 1013.4 3658.8 3721.6 3843.2 3906.9 3919.2 9383.9 9759.6 9807.6 9850.4 9857.4 9711.8 9721.3 9744.4 9802.9 9816.1 7370.9 7391.7 7452.6 7462.3 7463.2 5441.0 5477.7 5510.1 5629.5 5764.1 8872.5 8955.2 9070.5 9072.7 9173.6 8529.9 8874.2 8960.8 8975.7 8987.2 6045.4 6472.4 6644.4 6776.0 6958.1 7356.4 7397.2 7421.7 7425.3 7480.4 6622.7 6783.4 6817.2 6827.6 6899.5 6548.8 6599.1 6603.1 6624.0 6663.8 6456.9 6466.4 6488.2 6516.4 6558.7 4828.4 4852.3 4885.0 4905.3 4955.2 4738.9 4761.5 4806.4 4827.3 4873.5 07:47:12 INFO - PROCESS | 14127 | 07:47:12 INFO - PROCESS | 14127 | [#4] prototype.html Cycles:180 Average:4617.05 Median:5310.52 stddev:1353.64 (25.5%) stddev-sans-first:1318.29 07:47:12 INFO - PROCESS | 14127 | Values: 311.4 312.3 312.9 318.2 320.5 5350.7 5362.1 5377.8 5398.3 5421.3 5297.4 5308.9 5312.2 5313.0 5318.3 3924.4 3996.6 4163.5 4171.5 4191.7 4132.5 4159.1 4164.0 4164.9 4172.7 4108.3 4132.0 4143.3 4157.4 4162.6 4031.4 4107.3 4133.8 4142.9 4164.1 3600.9 3612.2 3636.9 3639.4 3660.5 5100.8 5101.3 5113.5 5123.9 5173.6 4605.1 4786.0 4795.1 4799.4 4821.3 5641.5 5643.5 5657.8 5668.5 5671.9 3993.6 4019.1 4028.3 4041.8 4046.8 5634.7 5832.3 5893.1 5924.0 5939.6 3926.2 3952.9 3967.4 3971.5 3974.1 4025.8 4034.7 4043.1 4046.2 4051.9 4567.2 4641.9 4656.7 4663.7 4671.9 5584.1 5653.7 5673.7 5676.1 5679.6 1404.9 1426.7 1428.4 1432.6 1433.8 874.2 906.4 932.5 946.9 948.9 4738.5 4762.9 4783.1 4794.7 4820.4 5693.8 5695.3 5717.1 5729.5 5733.5 4675.1 4748.0 4775.3 4810.6 4823.3 3055.3 3068.6 3081.4 3083.9 3096.7 5378.5 5387.5 5388.8 5389.8 5406.4 5681.9 5845.0 5865.4 5895.2 5904.5 5234.5 5264.9 5356.8 5372.1 5382.4 5493.1 5630.5 5686.6 5687.1 5694.0 5510.8 5578.7 5598.9 5607.6 5608.6 5339.9 5352.1 5371.3 5372.9 5386.8 3793.2 3965.2 3975.5 3975.7 3987.0 5744.3 5783.5 5804.2 5805.9 5816.8 5580.7 5591.9 5601.5 5633.2 5647.3 5290.7 5624.7 5645.6 5664.5 5675.2 5210.8 5525.4 5566.6 5569.2 5569.8 5441.3 5622.2 5645.5 5646.2 5681.1 5507.0 5516.0 5519.2 5545.7 5574.7 07:47:12 INFO - PROCESS | 14127 | 07:47:12 INFO - PROCESS | 14127 | [#5] yui.html Cycles:180 Average:12463.55 Median:51268.87 stddev:14368.47 (28.0%) stddev-sans-first:14381.73 07:47:12 INFO - PROCESS | 14127 | Values: 722.7 742.8 761.1 766.9 775.1 11013.9 11248.3 12032.6 12058.9 12061.9 11640.8 11738.5 11741.1 11769.6 11798.4 645.1 795.7 805.9 822.2 822.3 816.2 820.5 821.4 821.4 826.8 849.2 854.0 854.4 854.6 855.8 835.3 843.3 845.6 848.1 849.5 615.1 618.2 618.8 618.9 619.3 12053.2 12098.1 12100.7 12100.7 12126.6 12862.9 12955.7 12983.3 13062.3 13088.2 9782.6 10067.3 10223.2 10223.3 10585.5 3369.9 3375.1 3376.1 3405.4 3424.9 47481.0 47881.5 48003.5 48327.8 49549.8 9942.7 9976.5 9986.8 10119.5 10155.9 16430.7 16641.9 16684.7 16707.8 16742.0 6720.7 6767.2 6798.6 6890.0 6962.4 3687.2 3770.8 3771.0 3807.4 3822.9 2799.4 2898.6 2911.7 2916.8 2918.2 547.9 568.7 573.0 582.0 582.4 488.6 600.4 610.9 617.8 653.0 7513.6 7897.6 8017.2 8298.1 8387.8 493.2 604.0 637.1 642.3 647.3 3586.2 3935.4 3943.4 3959.7 4007.8 49028.5 50282.0 52255.7 52911.7 53130.0 44699.3 45409.0 45528.8 45601.8 45856.8 40431.6 42067.8 42119.4 42392.2 43055.1 7704.9 7712.4 7873.9 7912.3 8077.4 27015.0 27232.5 27454.7 27768.7 27900.9 37125.8 38216.2 38522.4 38539.8 39117.6 9200.8 9330.0 9468.8 9523.8 9632.8 10128.9 10162.2 10205.7 10601.2 10715.5 10067.0 10096.2 10132.3 10150.6 10342.2 9458.0 9692.2 9726.9 9820.5 9829.8 9686.4 9921.0 9974.8 9978.4 10016.0 8524.7 8662.7 8682.4 8935.2 9009.3 8826.0 8887.4 8903.7 8951.9 9063.9 07:47:12 INFO - PROCESS | 14127 | -------- Summary: end -------- 07:47:12 INFO - PROCESS | 14127 | 07:47:13 INFO - TEST-INFO | 14127: exit 0 07:47:13 INFO - TEST-OK | dromaeo_css | took 1113892ms 07:47:13 INFO - TEST-START | kraken 07:47:13 INFO - operating with platform_type : linux_ 07:47:13 INFO - Initialising browser for kraken test... 07:47:13 INFO - TEST-INFO | started process 14387 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO3ukIc/profile http://localhost:40248/getInfo.html) 07:47:17 INFO - PROCESS | 14387 | 07:47:17 INFO - PROCESS | 14387 | (process:14456): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:47:17 INFO - PROCESS | 14387 | __metrics Screen width/height:1600/1200 07:47:17 INFO - PROCESS | 14387 | colorDepth:24 07:47:17 INFO - PROCESS | 14387 | Browser inner width/height: 1024/697 07:47:17 INFO - PROCESS | 14387 | __metrics 07:47:18 ERROR - PROCESS | 14387 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 07:47:19 INFO - TEST-INFO | 14387: exit 0 07:47:19 INFO - Browser initialized. 07:47:19 INFO - Running cycle 1/1 for kraken test... 07:47:19 INFO - TEST-INFO | started process 14508 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO3ukIc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:47:21 INFO - PROCESS | 14508 | 07:47:21 INFO - PROCESS | 14508 | (process:14568): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:47:31 INFO - PROCESS | 14508 | RSS: Main: 164397056 07:47:31 INFO - PROCESS | 14508 | 07:47:33 INFO - PROCESS | 14508 | Cycle 1(1): loaded http://localhost:40248/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40248/tests/kraken/driver.html?testName=audio-beat-detection) 07:47:34 INFO - PROCESS | 14508 | RSS: Main: 167706624 07:47:34 INFO - PROCESS | 14508 | 07:47:37 INFO - PROCESS | 14508 | Cycle 1(1): loaded http://localhost:40248/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40248/tests/kraken/driver.html?testName=audio-dft) 07:47:38 INFO - PROCESS | 14508 | RSS: Main: 171110400 07:47:38 INFO - PROCESS | 14508 | 07:47:41 INFO - PROCESS | 14508 | Cycle 1(1): loaded http://localhost:40248/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40248/tests/kraken/driver.html?testName=audio-fft) 07:47:41 INFO - PROCESS | 14508 | RSS: Main: 163995648 07:47:41 INFO - PROCESS | 14508 | 07:47:43 INFO - PROCESS | 14508 | Cycle 1(1): loaded http://localhost:40248/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40248/tests/kraken/driver.html?testName=audio-oscillator) 07:47:44 INFO - PROCESS | 14508 | RSS: Main: 164491264 07:47:44 INFO - PROCESS | 14508 | 07:47:46 INFO - PROCESS | 14508 | Cycle 1(1): loaded http://localhost:40248/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40248/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:47:47 INFO - PROCESS | 14508 | RSS: Main: 165011456 07:47:47 INFO - PROCESS | 14508 | 07:47:50 INFO - PROCESS | 14508 | Cycle 1(1): loaded http://localhost:40248/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40248/tests/kraken/driver.html?testName=imaging-darkroom) 07:47:51 INFO - PROCESS | 14508 | RSS: Main: 165404672 07:47:51 INFO - PROCESS | 14508 | 07:47:54 INFO - PROCESS | 14508 | Cycle 1(1): loaded http://localhost:40248/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40248/tests/kraken/driver.html?testName=imaging-desaturate) 07:47:55 INFO - PROCESS | 14508 | RSS: Main: 162598912 07:47:55 INFO - PROCESS | 14508 | 07:47:58 INFO - PROCESS | 14508 | Cycle 1(1): loaded http://localhost:40248/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40248/tests/kraken/driver.html?testName=json-parse-financial) 07:47:58 INFO - PROCESS | 14508 | RSS: Main: 163622912 07:47:58 INFO - PROCESS | 14508 | 07:48:00 INFO - PROCESS | 14508 | Cycle 1(1): loaded http://localhost:40248/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40248/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:48:01 INFO - PROCESS | 14508 | RSS: Main: 163913728 07:48:01 INFO - PROCESS | 14508 | 07:48:03 INFO - PROCESS | 14508 | Cycle 1(1): loaded http://localhost:40248/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40248/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:48:03 INFO - PROCESS | 14508 | RSS: Main: 164118528 07:48:03 INFO - PROCESS | 14508 | 07:48:05 INFO - PROCESS | 14508 | Cycle 1(1): loaded http://localhost:40248/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40248/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:48:06 INFO - PROCESS | 14508 | RSS: Main: 164876288 07:48:06 INFO - PROCESS | 14508 | 07:48:09 INFO - PROCESS | 14508 | Cycle 1(1): loaded http://localhost:40248/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:48:10 INFO - PROCESS | 14508 | RSS: Main: 164859904 07:48:10 INFO - PROCESS | 14508 | 07:48:12 INFO - PROCESS | 14508 | Cycle 1(1): loaded http://localhost:40248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:48:13 INFO - PROCESS | 14508 | RSS: Main: 164753408 07:48:13 INFO - PROCESS | 14508 | 07:48:15 INFO - PROCESS | 14508 | Cycle 1(1): loaded http://localhost:40248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40248/tests/kraken/driver.html?testName=ai-astar) 07:48:15 INFO - PROCESS | 14508 | RSS: Main: 166105088 07:48:15 INFO - PROCESS | 14508 | 07:48:15 INFO - PROCESS | 14508 | __start_tp_report 07:48:15 INFO - PROCESS | 14508 | _x_x_mozilla_page_load 07:48:15 INFO - PROCESS | 14508 | _x_x_mozilla_page_load_details 07:48:15 INFO - PROCESS | 14508 | |i|pagename|runs| 07:48:15 INFO - PROCESS | 14508 | |0;ai-astar;116;110;115;113;114;126;114;116;114;113 07:48:15 INFO - PROCESS | 14508 | |1;audio-beat-detection;157;133;166;195;133;162;165;135;184;134 07:48:15 INFO - PROCESS | 14508 | |2;audio-dft;161;162;165;182;164;163;162;163;165;162 07:48:15 INFO - PROCESS | 14508 | |3;audio-fft;74;78;74;170;74;75;74;74;164;77 07:48:15 INFO - PROCESS | 14508 | |4;audio-oscillator;93;95;143;94;93;95;151;95;95;144 07:48:15 INFO - PROCESS | 14508 | |5;imaging-gaussian-blur;117;119;117;117;118;118;119;118;118;120 07:48:15 INFO - PROCESS | 14508 | |6;imaging-darkroom;148;149;147;146;148;149;147;148;148;146 07:48:15 INFO - PROCESS | 14508 | |7;imaging-desaturate;95;95;96;95;96;96;96;95;96;95 07:48:15 INFO - PROCESS | 14508 | |8;json-parse-financial;66;65;66;66;69;66;69;90;66;74 07:48:15 INFO - PROCESS | 14508 | |9;json-stringify-tinderbox;64;64;65;64;65;64;65;65;65;65 07:48:15 INFO - PROCESS | 14508 | |10;stanford-crypto-aes;78;80;80;89;80;81;81;79;81;83 07:48:15 INFO - PROCESS | 14508 | |11;stanford-crypto-ccm;143;138;135;134;136;135;138;135;168;143 07:48:15 INFO - PROCESS | 14508 | |12;stanford-crypto-pbkdf2;179;174;183;179;175;173;174;172;174;173 07:48:15 INFO - PROCESS | 14508 | |13;stanford-crypto-sha256-iterative;77;74;75;74;73;75;73;72;73;74 07:48:15 INFO - PROCESS | 14508 | __end_tp_report 07:48:15 INFO - PROCESS | 14508 | __start_cc_report 07:48:15 INFO - PROCESS | 14508 | _x_x_mozilla_cycle_collect,907 07:48:15 INFO - PROCESS | 14508 | __end_cc_report 07:48:15 INFO - PROCESS | 14508 | __startTimestamp1460990895722__endTimestamp 07:48:15 INFO - PROCESS | 14508 | 07:48:15 INFO - PROCESS | 14508 | ------- Summary: start ------- 07:48:15 INFO - PROCESS | 14508 | Number of tests: 14 07:48:15 INFO - PROCESS | 14508 | 07:48:15 INFO - PROCESS | 14508 | [#0] ai-astar Cycles:10 Average:115.10 Median:114.50 stddev:4.20 (3.7%) stddev-sans-first:4.44 07:48:15 INFO - PROCESS | 14508 | Values: 116.0 110.0 115.0 113.0 114.0 126.0 114.0 116.0 114.0 113.0 07:48:15 INFO - PROCESS | 14508 | 07:48:15 INFO - PROCESS | 14508 | [#1] audio-beat-detection Cycles:10 Average:156.40 Median:163.50 stddev:22.37 (13.7%) stddev-sans-first:23.73 07:48:15 INFO - PROCESS | 14508 | Values: 157.0 133.0 166.0 195.0 133.0 162.0 165.0 135.0 184.0 134.0 07:48:15 INFO - PROCESS | 14508 | 07:48:15 INFO - PROCESS | 14508 | [#2] audio-dft Cycles:10 Average:164.90 Median:163.50 stddev:6.15 (3.8%) stddev-sans-first:6.36 07:48:15 INFO - PROCESS | 14508 | Values: 161.0 162.0 165.0 182.0 164.0 163.0 162.0 163.0 165.0 162.0 07:48:15 INFO - PROCESS | 14508 | 07:48:15 INFO - PROCESS | 14508 | [#3] audio-fft Cycles:10 Average:93.40 Median:74.00 stddev:38.84 (52.5%) stddev-sans-first:40.56 07:48:15 INFO - PROCESS | 14508 | Values: 74.0 78.0 74.0 170.0 74.0 75.0 74.0 74.0 164.0 77.0 07:48:15 INFO - PROCESS | 14508 | 07:48:15 INFO - PROCESS | 14508 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:94.50 stddev:25.08 (26.5%) stddev-sans-first:25.85 07:48:15 INFO - PROCESS | 14508 | Values: 93.0 95.0 143.0 94.0 93.0 95.0 151.0 95.0 95.0 144.0 07:48:15 INFO - PROCESS | 14508 | 07:48:15 INFO - PROCESS | 14508 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:0.99 (0.8%) stddev-sans-first:0.97 07:48:15 INFO - PROCESS | 14508 | Values: 117.0 119.0 117.0 117.0 118.0 118.0 119.0 118.0 118.0 120.0 07:48:15 INFO - PROCESS | 14508 | 07:48:15 INFO - PROCESS | 14508 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:1.07 (0.7%) stddev-sans-first:1.13 07:48:15 INFO - PROCESS | 14508 | Values: 148.0 149.0 147.0 146.0 148.0 149.0 147.0 148.0 148.0 146.0 07:48:15 INFO - PROCESS | 14508 | 07:48:15 INFO - PROCESS | 14508 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 07:48:15 INFO - PROCESS | 14508 | Values: 95.0 95.0 96.0 95.0 96.0 96.0 96.0 95.0 96.0 95.0 07:48:15 INFO - PROCESS | 14508 | 07:48:15 INFO - PROCESS | 14508 | [#8] json-parse-financial Cycles:10 Average:69.70 Median:67.50 stddev:7.62 (11.3%) stddev-sans-first:7.96 07:48:15 INFO - PROCESS | 14508 | Values: 66.0 65.0 66.0 66.0 69.0 66.0 69.0 90.0 66.0 74.0 07:48:15 INFO - PROCESS | 14508 | 07:48:15 INFO - PROCESS | 14508 | [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:65.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 07:48:15 INFO - PROCESS | 14508 | Values: 64.0 64.0 65.0 64.0 65.0 64.0 65.0 65.0 65.0 65.0 07:48:15 INFO - PROCESS | 14508 | 07:48:15 INFO - PROCESS | 14508 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:81.00 stddev:3.05 (3.8%) stddev-sans-first:3.00 07:48:15 INFO - PROCESS | 14508 | Values: 78.0 80.0 80.0 89.0 80.0 81.0 81.0 79.0 81.0 83.0 07:48:15 INFO - PROCESS | 14508 | 07:48:15 INFO - PROCESS | 14508 | [#11] stanford-crypto-ccm Cycles:10 Average:140.50 Median:138.00 stddev:10.19 (7.4%) stddev-sans-first:10.77 07:48:15 INFO - PROCESS | 14508 | Values: 143.0 138.0 135.0 134.0 136.0 135.0 138.0 135.0 168.0 143.0 07:48:15 INFO - PROCESS | 14508 | 07:48:15 INFO - PROCESS | 14508 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.60 Median:174.50 stddev:3.53 (2.0%) stddev-sans-first:3.53 07:48:15 INFO - PROCESS | 14508 | Values: 179.0 174.0 183.0 179.0 175.0 173.0 174.0 172.0 174.0 173.0 07:48:15 INFO - PROCESS | 14508 | 07:48:15 INFO - PROCESS | 14508 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.00 Median:74.00 stddev:1.41 (1.9%) stddev-sans-first:1.00 07:48:15 INFO - PROCESS | 14508 | Values: 77.0 74.0 75.0 74.0 73.0 75.0 73.0 72.0 73.0 74.0 07:48:15 INFO - PROCESS | 14508 | -------- Summary: end -------- 07:48:15 INFO - PROCESS | 14508 | 07:48:16 INFO - TEST-INFO | 14508: exit 0 07:48:16 INFO - TEST-OK | kraken | took 63057ms 07:48:16 INFO - SUITE-END | took 1176s 07:48:16 INFO - Completed test suite (00:19:37) 07:48:16 INFO - javascript benchmark 07:48:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2621.960670589941, 2695.743904329088, 2727.2909043648656, 2730.890764369425, 2739.0687166363446, 4791.568758811706, 4794.280857871321, 4820.807167713296, 4847.515248475155, 4901.166801643721, 4723.0, 4796.640251981106, 4810.182269014267, 4850.1027309947685, 4873.415190177175, 4406.118776244748, 4429.64562834974, 4490.842820501283, 4506.639468842484, 4517.186906356855, 4419.823207071713, 4540.046590216059, 4543.704659197158, 4573.748443835588, 4581.793819278124, 4260.1905637929, 4288.120935208306, 4356.869293921188, 4457.974665826846, 4503.572160644766, 4321.222180007598, 4354.54277300882, 4357.9782101089295, 4388.692791504596, 4405.449318835145, 4339.7830108494445, 4367.716098453622, 4374.409454723604, 4384.123175364908, 4430.534793846632, 4642.721436713808, 4656.394668693082, 4699.765011749433, 4701.318308845232, 4738.526147385269, 5007.424146223195, 5036.470308411952, 5046.21783623539, 5068.695878247317, 5095.515925987025, 4988.975055124737, 5087.618428617869, 5105.030044291572, 5113.769880355356, 5155.587552995751, 4784.091022705709, 4843.588294994965, 4854.19905715553, 4857.0528746894015, 4907.55831975124, 5209.869753256123, 5213.504717051874, 5221.765020574007, 5243.947560524422, 5308.814191503279, 4854.101991131652, 4951.059298733229, 4998.675086119463, 5005.549500544968, 5031.622628302892, 5102.668326558762, 5118.053160165381, 5134.845954621367, 5149.0, 5187.922181167285, 4915.827946021872, 5095.439501654815, 5123.257127716534, 5146.819861304836, 5186.714730689849, 4935.383077115361, 5005.998800239967, 5039.21892106724, 5049.469805670426, 5113.054084994214, 4280.250956082673, 4322.481302243751, 4337.15425492026, 4338.891527711769, 4382.320740285261, 3762.435634654824, 3763.7741735495956, 3774.6036666149657, 3813.1420430402936, 3824.6175382461533, 4297.269464191095, 4360.258756011485, 4421.977890110529, 4433.334999749999, 4507.887302817456, 5126.0, 5139.511746384088, 5139.717315547681, 5148.0476111919415, 5169.7932082717025, 4475.619572336388, 4479.3057076153245, 4482.125985432809, 4487.730736155841, 4523.773811309421, 4496.303073023687, 4566.657500687462, 4665.95334046662, 4670.509596492388, 4687.062587482449, 4816.34979277807, 4821.975890120527, 4823.614110871122, 4834.540718631724, 4852.0295940811275, 5130.050940576006, 5154.098032844312, 5166.405863325615, 5169.638125331341, 5225.947740522546, 4716.952830471651, 4856.951430485791, 4895.902081958412, 4906.607471402351, 4943.258511223202, 5056.57019153376, 5061.987602479445, 5063.87340316495, 5074.644774865724, 5131.435542090292, 4972.453030166751, 5142.1258386073705, 5150.742462876766, 5151.459096794782, 5156.381234251914, 4885.731284779371, 4935.555799978019, 4937.703737775745, 4939.802407903788, 4999.525045120708, 4931.137051015986, 4953.009398120463, 4979.0788704089855, 4985.52637499437, 5018.84943451697, 4840.031993601224, 4889.951100489092, 4891.877703057452, 4894.755262236945, 4941.283513890394, 4880.194767863263, 5027.773750181177, 5035.118854200574, 5112.948870511247, 5117.0, 4823.324734537097, 4840.0, 4856.684315519621, 4857.781399837087, 4864.73243971585], "value": 4700.786201300058, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.6917033971996, 603.3453702732535, 614.6158650843223, 617.3271134463436, 642.7718160053178, 33151.83424082879, 34473.0, 34488.82755586225, 34498.827505862464, 34532.30935381294, 34233.65766342336, 34707.82646086772, 34865.12837179072, 34927.82536087323, 35048.29903401931, 7408.96295518523, 7626.961865190667, 7627.0, 7637.732679356196, 7650.120236172856, 7418.072740907387, 7686.231376862297, 7701.037370328709, 7717.575533345664, 7745.457817952745, 7706.383489320869, 7773.689052437896, 7779.727709530168, 7779.805504862367, 7789.143194248628, 7692.4999875008225, 7713.884291735629, 7714.575698336589, 7735.690572377098, 7750.263724946121, 7654.158042615308, 7687.577183254919, 7759.418043646749, 7789.649465773997, 7789.961050194769, 29278.560821587693, 34755.47866782, 35374.823125884206, 35409.64590354089, 35431.0, 2755.931101722453, 2856.6286382770313, 2856.8428736419696, 2903.9274018149504, 2974.4794660934467, 27472.725272747215, 27727.445451090865, 27800.165995020183, 28363.149105526867, 28920.26478411302, 3477.2697733476, 3482.6517348265224, 3500.2824420993634, 3517.1734642359024, 3531.29374125176, 191094.0, 195016.0, 196066.0, 196249.0, 196649.0, 55966.72016639891, 57250.71374643184, 57270.42729572651, 57294.427055728906, 57356.71321643365, 62501.687491562254, 64509.0, 64685.67657161778, 64777.35222647808, 64947.35052649413, 13385.93307033478, 13496.0, 13503.12229705066, 13527.32363381827, 13571.728565428637, 9564.904350956402, 9666.033396660418, 9674.661386851427, 9754.365966212174, 9848.852267215998, 19499.415017549498, 19734.30929917446, 19745.308914187935, 19812.603747925248, 19837.80973141616, 7544.962275188589, 7758.198482743528, 7825.37397008238, 7943.24539168778, 7984.4810087345295, 874.6239117179674, 952.6713283917038, 973.9432715503616, 975.512243878061, 994.2940512236248, 27369.0, 27635.0, 28733.425331493254, 28814.135575932756, 28835.85582072076, 975.7219192530094, 1008.6520150548049, 1045.0333441566672, 1056.4506456642503, 1061.5435362794074, 14427.855721442862, 15192.924035379974, 15205.31576079079, 15438.0, 15472.226388680521, 337476.0, 342006.0, 345673.0, 347436.0, 347509.0, 48297.27554086692, 48463.51536484661, 49054.26418603724, 49331.75334123307, 49488.0, 1201.1711918776016, 1228.7603917236231, 1240.8200810882552, 1249.443997421157, 1255.7802384582662, 26089.0, 27196.864015679796, 27752.0, 27972.860135700004, 29148.854255728587, 46898.76550617225, 47864.282035770186, 48115.0, 48157.27764083471, 48215.75892120517, 322660.0, 327000.0, 327639.0, 328554.0, 331452.0, 38468.23063538658, 38751.0, 39109.0, 39597.20805583814, 40071.799641001606, 42347.7882610585, 42366.57633423626, 42994.57005429906, 43336.783316083216, 43448.56551434445, 36544.0863978392, 36609.0, 36913.630863692095, 36972.26055478821, 37177.070573235884, 35720.82139589285, 36930.44604330991, 36948.815255923546, 37117.443238350905, 37653.435198472594, 35783.0, 36035.63964360323, 36049.63950360568, 36554.268914621025, 37234.0, 32542.83728581342, 33010.66989330172, 33246.00315579559, 33311.50032749462, 33886.491702624975, 25274.873625631753, 25368.238952831445, 25664.743352566235, 26182.60726089072, 26525.86737066302], "value": 17631.340065122506, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.94476300936367, 383.9328117579424, 390.95699473057965, 395.60637166019814, 401.7248184993278, 14941.402343906244, 16911.49265522036, 17534.82465175348, 17725.82274177258, 17761.555961100978, 16395.91802040988, 17042.65914681709, 17289.654206915853, 17301.22144503497, 17379.47861564152, 5000.424951130612, 5189.117849965496, 5192.039472697544, 5213.687178769267, 5220.112580861243, 3693.1321139532324, 5632.7183640818, 5909.852253693649, 5918.585699001072, 5949.6727679977585, 5634.32388113427, 5873.0, 5881.852953676171, 5898.0, 5905.025670764318, 5798.478136967672, 5852.970735146339, 5894.2926848778425, 5895.587308888358, 5916.704164791765, 5024.572911302544, 5122.290952117077, 5130.30740849988, 5186.403563590197, 5189.1956746703945, 20393.796062039488, 20415.693764593394, 20612.484687882774, 20805.687914681293, 20831.791682083287, 1962.3426152239017, 2005.1678553400322, 2008.1465377214624, 2103.82117520011, 2230.9291540060863, 12963.67590810228, 13220.272884991322, 13363.331833408389, 13495.86504134956, 13534.932325338408, 1666.5666926599172, 1784.1881943715578, 1807.8644101692425, 1847.0303090877262, 1887.8867267963967, 66843.3315666842, 68392.0, 68741.65629171873, 68818.65590672015, 69114.65442672804, 9157.679481218125, 9330.766730831649, 9638.0, 9781.510924453749, 9864.457454840052, 13614.0, 13633.659158521117, 13681.726365472634, 13706.65733356674, 13723.862761372458, 6849.589024658537, 6890.069840571458, 6899.448044156556, 7006.4745144114395, 7072.575645461289, 6393.424591786761, 6511.186101737283, 6599.769008084694, 6619.271880093186, 6656.0, 5943.881122377615, 6125.264968203844, 6139.6009259398, 6189.731105123529, 6190.845228869224, 1597.6565038516774, 1690.8309169082993, 1783.2599471219557, 1809.9457016289532, 1838.1820090060062, 898.9775255618662, 946.0161432110528, 972.3145182646217, 973.5132433783108, 998.5306905754284, 16304.266308016167, 16680.666386672197, 16885.40901068457, 17000.82999170017, 17030.318787248372, 868.6221493650282, 872.1757938747949, 892.2594246775161, 902.3999040637902, 939.5067589515559, 9604.279679024101, 9669.806603868024, 9702.6118955241, 9802.607895684092, 9812.018798120274, 440519.0, 442247.0, 447421.0, 457157.0, 471596.0, 82328.58835705783, 84977.15022849692, 86278.56860715656, 86955.0, 87576.0, 933.5518950903469, 977.0522593084696, 978.114806100466, 984.8227319082633, 989.2382865193904, 15417.306221220297, 15451.768223476432, 15560.766588500956, 15626.45307414235, 15936.840631593535, 34949.0, 35431.64568354283, 36572.0, 36601.63398366089, 36727.0, 45285.0, 47597.0, 49429.25856112089, 51559.0, 51995.74002129965, 7629.656665450179, 7646.885296720665, 7751.728689495841, 7793.64928578204, 7839.25527074927, 8484.321254299517, 10871.273537515817, 11664.0, 11784.58753943608, 12026.939865300617, 10104.747381315232, 10110.747231319276, 10421.895781042092, 10577.259591828499, 10586.8941310589, 9997.500124993867, 10526.473676316, 10645.414502202453, 10670.57317707314, 10820.350778953289, 10387.272890897564, 10484.63303784364, 10505.474726263808, 10728.088112510524, 10835.837462437912, 7811.1017233016655, 7842.882356764539, 7860.788770586693, 7879.369650428067, 7978.361731061617, 7348.889766653398, 8395.0, 9400.76498087526, 9461.668841590512, 9556.617735290789], "value": 8462.58343667594, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1404.84546699863, 1464.1727424005437, 1592.8805339599526, 1779.9644007119866, 1821.8542516598673, 6746.797596072113, 7288.708451661933, 7601.505902116359, 7602.315791578763, 7631.236876312366, 7666.501677390966, 7685.846283074336, 7746.457747957646, 7749.147593764681, 7753.457257991929, 2190.3647942096773, 2213.214308920334, 2217.866927984326, 2219.1012639880873, 2232.6092933736613, 2160.0, 2198.076807740753, 2208.5803697297542, 2209.4476380904775, 2210.613142700029, 2166.6425039868404, 2189.9890500547476, 2191.9452013699706, 2195.473086459246, 2197.813185879202, 2110.862793918398, 2115.9894200528975, 2116.7354080739906, 2118.7245658064508, 2121.628714974873, 2065.1429656692453, 2152.7416709994745, 2174.913003479859, 2180.7819218078225, 2180.967285490719, 7836.568988705619, 7889.1716369780925, 7889.566073865935, 7939.801504962365, 7958.045034595828, 4746.21687421575, 4940.1601727706375, 4958.528939750718, 4972.7513624319, 4975.4029516457895, 2821.957670634942, 2847.9145625631263, 2945.2784067903285, 2983.74638155757, 3006.879724811005, 847.8728190771373, 865.7489328094845, 867.9609417576224, 868.8653258744905, 883.6112110671284, 10736.624218152405, 10736.73158171052, 10774.084202842767, 10785.0, 10786.946065269702, 4312.331588603772, 4328.458942632171, 4487.483939346952, 4535.478419981679, 4560.543945605413, 7808.57052862098, 7878.290953814184, 7886.487378320391, 7933.722319718782, 7940.920590794018, 4551.067031258584, 4566.748828814447, 4568.0, 4569.040501494724, 4573.108243892476, 3730.477733117366, 4162.084341444877, 4195.412642230091, 4263.0, 4358.171947329997, 3538.9469157962653, 3633.255182687543, 3640.43573246142, 3681.079730067483, 3792.393217085253, 1083.1876092930302, 1092.317301686446, 1093.5516438260274, 1097.0894157848966, 1101.4767985206963, 865.913408659129, 873.0963452826294, 874.1477059866706, 878.508035500122, 895.136193573205, 5410.269613602192, 5509.862253443696, 5523.558115350762, 5645.463680950304, 5712.857178570569, 953.2564599612314, 954.8376775948105, 992.717075633441, 1000.9299349045497, 1013.4020927652573, 3658.817059147032, 3721.5906250312987, 3843.2121415109837, 3906.882793516199, 3919.2161567686576, 9383.859242111374, 9759.560819763128, 9807.558659860324, 9850.359726617748, 9857.35927164732, 9711.757206069904, 9721.270904682036, 9744.366616169926, 9802.901970980342, 9816.116549510578, 7370.926290737131, 7391.704331826667, 7452.5528468290995, 7462.253774622603, 7463.216362281991, 5441.0478166319945, 5477.726113694379, 5510.090835012178, 5629.521490673174, 5764.13537969308, 8872.512011839412, 8955.194032537103, 9070.455772653662, 9072.727818165466, 9173.587188576663, 8529.91470085316, 8874.156955089256, 8960.775980600276, 8975.730728078168, 8987.191152796018, 6045.425684559959, 6472.35276472349, 6644.368784965421, 6775.966120169368, 6958.060661810793, 7356.374708149653, 7397.186309506058, 7421.740239091606, 7425.257474252531, 7480.364169045474, 6622.735090596322, 6783.389494945479, 6817.181938167451, 6827.590344579341, 6899.48253880971, 6548.770793022221, 6599.0761293418, 6603.108580341785, 6624.039514270307, 6663.800085997428, 6456.935430645822, 6466.353364663684, 6488.156539649815, 6516.413522782972, 6558.672066396565, 4828.396450443694, 4852.344933434082, 4885.047415753894, 4905.298418078569, 4955.231939049453, 4738.928916066331, 4761.452432970253, 4806.375171227718, 4827.25177597473, 4873.537013983666], "value": 4184.931716118101, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.3850145961726, 312.32537718527976, 312.8983080498837, 318.1854452601341, 320.47122248290333, 5350.732463376826, 5362.1420572708375, 5377.7580008899595, 5398.271233383487, 5421.268128802611, 5297.3713006590515, 5308.867278318044, 5312.1766126250495, 5313.0, 5318.282031925689, 3924.4113382992496, 3996.561237954334, 4163.50037995441, 4171.457710497646, 4191.664666826662, 4132.524759652633, 4159.147374788161, 4164.0, 4164.917960709068, 4172.70791044627, 4108.26051310764, 4132.0, 4143.254214241435, 4157.355609880458, 4162.562930892258, 4031.395290706388, 4107.342825147992, 4133.813978370966, 4142.91714165718, 4164.12553363794, 3600.9099772505633, 3612.151144481045, 3636.890893273206, 3639.3631114554846, 3660.5424321959754, 5100.846974590768, 5101.260317254015, 5113.488651134894, 5123.897522049576, 5173.586113110942, 4605.125026245003, 4786.0, 4795.112904112751, 4799.352087468182, 4821.252705830567, 5641.464060914206, 5643.492085712305, 5657.773689052433, 5668.546516278688, 5671.914921276184, 3993.6206060424215, 4019.135885784541, 4028.2950483665536, 4041.838326466938, 4046.8381264749373, 5634.690092044936, 5832.250324902512, 5893.086571581412, 5923.970380148072, 5939.584229103964, 3926.1951299983434, 3952.8616498422994, 3967.385055316373, 3971.5035620547433, 3974.0859602291634, 4025.7987100645437, 4034.7175697700877, 4043.130726893673, 4046.2109888572036, 4051.8987025324604, 4567.1550763108935, 4641.930371044437, 4656.650751193674, 4663.673542851968, 4671.883202919887, 5584.078627026495, 5653.689047102449, 5673.687947162945, 5676.091825307931, 5679.630823996427, 1404.9157050576998, 1426.721789251086, 1428.3787900732743, 1432.584550480349, 1433.806436131109, 874.2394117118148, 906.4470672889532, 932.48247222792, 946.9005754395827, 948.9182332141364, 4738.455077666113, 4762.928556071662, 4783.115123702126, 4794.712317260975, 4820.421549414093, 5693.800716974969, 5695.316562012502, 5717.085266357363, 5729.455701708331, 5733.541316694655, 4675.13510000651, 4748.0, 4775.283707443842, 4810.6151507879285, 4823.300621409946, 3055.297281625194, 3068.647105582842, 3081.4145312390574, 3083.92290192747, 3096.674849140853, 5378.542823860016, 5387.542058925035, 5388.763663079856, 5389.784408623689, 5406.351237851483, 5681.897697851821, 5845.0, 5865.445656900924, 5895.204147440127, 5904.468597826216, 5234.476552344811, 5264.89470210586, 5356.839294821161, 5372.140457526777, 5382.354117505846, 5493.148561972901, 5630.549556035589, 5686.60193786431, 5687.118496633028, 5694.0, 5510.768138903751, 5578.665280083208, 5598.944010559842, 5607.5513958884, 5608.551315894637, 5339.893202136013, 5352.143657014859, 5371.274877891435, 5372.892542149057, 5386.8383948481605, 3793.165503589206, 3965.2267807777207, 3975.5030621172355, 3975.747639493666, 3987.0431096537204, 5744.253247077853, 5783.479486846036, 5804.187413762161, 5805.941940580709, 5816.796412125725, 5580.665160090245, 5591.862022103695, 5601.467860553241, 5633.2395126657375, 5647.29408823897, 5290.65610735301, 5624.6625202487985, 5645.633033852787, 5664.546836253007, 5675.177099320658, 5210.765515551733, 5525.419830917695, 5566.582506312124, 5569.164625306236, 5569.8024924641395, 5441.347038355423, 5622.18478320633, 5645.463680950304, 5646.181303711021, 5681.147827825859, 5506.972465137809, 5515.972420137874, 5519.199716041232, 5545.694986775766, 5574.665520068809], "value": 4181.954593508878, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [722.7181399254292, 742.7736181129374, 761.094297785635, 766.877299632059, 775.0505630602516, 11013.944930275347, 11248.325100493967, 12032.639020829367, 12058.879411205886, 12061.879381206185, 11640.825387619172, 11738.530458781639, 11741.119416043788, 11769.588064417747, 11798.351090690008, 645.0678769178539, 795.6658203554521, 805.8791181322819, 822.1696086952162, 822.268181318627, 816.1878930464196, 820.5035953248289, 821.3552361396305, 821.4167940762067, 826.7519744076783, 849.2441726863096, 854.0306751836679, 854.4189950833431, 854.5940678177847, 855.7860534866284, 835.3108685334593, 843.2537204573935, 845.6321500147455, 848.0628905059882, 849.5370023337265, 615.1449485215554, 618.2086928731231, 618.7555915413386, 618.8886000519905, 619.2692622705206, 12053.15627906047, 12098.092643051807, 12100.697482563006, 12100.697482563006, 12126.636200913987, 12862.871371286261, 12955.740885182244, 12983.285919274436, 13062.34688265583, 13088.214707117604, 9782.608695652165, 10067.29528932975, 10223.233257505717, 10223.335483193569, 10585.523651435704, 3369.898903032913, 3375.0887260439545, 3376.1053320869987, 3405.387030334539, 3424.931501369959, 47481.0, 47881.521184788406, 48003.51996480025, 48327.75836120832, 49549.752251238875, 9942.701718948443, 9976.501174941224, 9986.750331241778, 10119.544620492095, 10155.949220253851, 16430.6713865722, 16641.916790416213, 16684.74972875408, 16707.83292167087, 16742.0, 6720.697568609425, 6767.154105736783, 6798.592084474848, 6890.0, 6962.373386395248, 3687.1519550503535, 3770.816812053969, 3771.0, 3807.371783655721, 3822.8853134406013, 2799.440111977572, 2898.594196812448, 2911.694272101441, 2916.8104073235595, 2918.1829087855435, 547.8739889825363, 568.6815383385317, 572.9627574207747, 581.9621724587888, 582.3943099176894, 488.5676176583678, 600.354618784808, 610.8533951851613, 617.7621615677996, 652.9608223506605, 7513.586752728653, 7897.60511974399, 8017.158198389086, 8298.128696486903, 8387.790305242417, 493.1788572027534, 603.9547033972382, 637.1366797988659, 642.322349920838, 647.346180357842, 3586.1751797086818, 3935.370340745467, 3943.38877473992, 3959.7228194026143, 4007.757595145514, 49028.509714903106, 50282.0, 52255.73872130615, 52911.73544132255, 53130.0, 44699.329510057374, 45409.0, 45528.77235613867, 45601.77199114049, 45856.77071614687, 40431.59568404278, 42067.7896610515, 42119.36820947688, 42392.15215695669, 43055.1388972225, 7704.92295077042, 7712.421568382281, 7873.881891771743, 7912.32745216663, 8077.434579579608, 27015.0, 27232.455350893266, 27454.725452745217, 27768.722312777423, 27900.86049569739, 37125.814370927976, 38216.23567528578, 38522.422163667004, 38539.807300963315, 39117.608823911396, 9200.815983680423, 9330.0, 9468.755303960756, 9523.809523809347, 9632.807343852943, 10128.949355253177, 10162.23783216247, 10205.693829185137, 10601.204909631655, 10715.464226788474, 10067.0, 10096.242781791541, 10132.290739648153, 10150.593976240867, 10342.224333174892, 9458.0, 9692.176165026052, 9726.902730972599, 9820.508974551101, 9829.754256143653, 9686.418814871131, 9921.0497496093, 9974.750631234278, 9978.351407158512, 10016.0, 8524.74425767228, 8662.696805611773, 8682.43564168327, 8935.195832375117, 9009.279257659502, 8825.955870220609, 8887.37788354809, 8903.688370906988, 8951.865722014305, 9063.909360906306], "value": 5833.769861950364, "unit": "score"}], "name": "dromaeo_css", "value": 6444.219146022513, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 110.0, 115.0, 113.0, 114.0, 126.0, 114.0, 116.0, 114.0, 113.0], "value": 115.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 133.0, 166.0, 195.0, 133.0, 162.0, 165.0, 135.0, 184.0, 134.0], "value": 156.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 165.0, 182.0, 164.0, 163.0, 162.0, 163.0, 165.0, 162.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 78.0, 74.0, 170.0, 74.0, 75.0, 74.0, 74.0, 164.0, 77.0], "value": 93.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 143.0, 94.0, 93.0, 95.0, 151.0, 95.0, 95.0, 144.0], "value": 109.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 117.0, 117.0, 118.0, 118.0, 119.0, 118.0, 118.0, 120.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 147.0, 146.0, 148.0, 149.0, 147.0, 148.0, 148.0, 146.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 66.0, 69.0, 66.0, 69.0, 90.0, 66.0, 74.0], "value": 69.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 64.0, 65.0, 64.0, 65.0, 65.0, 65.0, 65.0], "value": 64.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 80.0, 80.0, 89.0, 80.0, 81.0, 81.0, 79.0, 81.0, 83.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 138.0, 135.0, 134.0, 136.0, 135.0, 138.0, 135.0, 168.0, 143.0], "value": 140.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 174.0, 183.0, 179.0, 175.0, 173.0, 174.0, 172.0, 174.0, 173.0], "value": 175.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 75.0, 74.0, 73.0, 75.0, 73.0, 72.0, 73.0, 74.0], "value": 74.0, "unit": "score"}], "name": "kraken", "value": 1606.3999999999999, "alertThreshold": 2.0}]} 07:48:16 INFO - Return code: 0 07:48:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:48:17 ERROR - # TBPL SUCCESS # 07:48:17 INFO - Running post-action listener: _resource_record_post_action 07:48:17 INFO - Running post-run listener: _resource_record_post_run 07:48:18 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 20480; Write bytes: 526004224; Read time: 80; Write time: 527524 07:48:18 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 216887296; Read time: 0; Write time: 325028 07:48:18 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 20480; Write bytes: 285032448; Read time: 80; Write time: 195752 07:48:18 INFO - Running post-run listener: _upload_blobber_files 07:48:18 INFO - Blob upload gear active. 07:48:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:48:18 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 07:48:18 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'] 07:48:18 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 07:48:18 INFO - (blobuploader) - INFO - Open directory for files ... 07:48:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:48:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:48:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:48:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:48:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:48:19 INFO - (blobuploader) - INFO - Done attempting. 07:48:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:48:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:48:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:48:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:48:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:48:21 INFO - (blobuploader) - INFO - Done attempting. 07:48:21 INFO - (blobuploader) - INFO - Iteration through files over. 07:48:21 INFO - Return code: 0 07:48:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:48:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:48:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f135ca013199d56579c7bc29dde097454bb274522d5afe79dcf7bea66399de621c5a3567d48d20179ea5e09f99b13d914c0cbf79d2c0f99e631c934cc83b06f7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/915bb5afb4cf236e194be0910f42c9ef432ab0604f810cd1e0635680ae7e8e525ce77e89d66e7a5f709d0d2f413a55674bba7ddb513cdb4904ab50c64d1dec12"} 07:48:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:48:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:48:21 INFO - Contents: 07:48:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f135ca013199d56579c7bc29dde097454bb274522d5afe79dcf7bea66399de621c5a3567d48d20179ea5e09f99b13d914c0cbf79d2c0f99e631c934cc83b06f7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/915bb5afb4cf236e194be0910f42c9ef432ab0604f810cd1e0635680ae7e8e525ce77e89d66e7a5f709d0d2f413a55674bba7ddb513cdb4904ab50c64d1dec12"} 07:48:21 INFO - Running post-run listener: copy_logs_to_upload_dir 07:48:21 INFO - Copying logs to upload dir... 07:48:21 INFO - mkdir: /builds/slave/test/build/upload/logs 07:48:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.257305 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-04-18 07:48:19.958786) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 07:48:19.962564) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1460989303.68382-256540036 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f135ca013199d56579c7bc29dde097454bb274522d5afe79dcf7bea66399de621c5a3567d48d20179ea5e09f99b13d914c0cbf79d2c0f99e631c934cc83b06f7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/915bb5afb4cf236e194be0910f42c9ef432ab0604f810cd1e0635680ae7e8e525ce77e89d66e7a5f709d0d2f413a55674bba7ddb513cdb4904ab50c64d1dec12"} build_url:https://queue.taskcluster.net/v1/task/T4QvblmPSfiRuWEIfeMGXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011151 build_url: 'https://queue.taskcluster.net/v1/task/T4QvblmPSfiRuWEIfeMGXg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f135ca013199d56579c7bc29dde097454bb274522d5afe79dcf7bea66399de621c5a3567d48d20179ea5e09f99b13d914c0cbf79d2c0f99e631c934cc83b06f7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/915bb5afb4cf236e194be0910f42c9ef432ab0604f810cd1e0635680ae7e8e525ce77e89d66e7a5f709d0d2f413a55674bba7ddb513cdb4904ab50c64d1dec12"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 07:48:19.987461) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 07:48:19.987804) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1460989303.68382-256540036 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004581 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 07:48:20.069251) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 07:48:20.069606) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 07:48:20.069950) ========= ========= Total master_lag: 0.18 =========