builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-024 starttime: 1462525360.93 results: success (0) buildid: 20160505233053 builduid: f4eae97c061745349a9df383ac529b6b revision: 9e9cb8b89a1091c9b9e582c2865a771f9a2a0936 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 02:02:40.925441) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-06 02:02:40.926182) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 02:02:40.926472) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-06 02:02:40.958843) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 02:02:40.959240) ========= 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=7cf709767345e0a0c5a90e72000001d4-1462525156.380733-2130376568 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-06 02:02:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 71.0M=0s 2016-05-06 02:02:41 (71.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.165008 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 02:02:41.163349) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 02:02:41.163631) ========= 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=7cf709767345e0a0c5a90e72000001d4-1462525156.380733-2130376568 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.052668 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 02:02:41.232451) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-05-06 02:02:41.232806) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9e9cb8b89a1091c9b9e582c2865a771f9a2a0936 --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 9e9cb8b89a1091c9b9e582c2865a771f9a2a0936 --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=7cf709767345e0a0c5a90e72000001d4-1462525156.380733-2130376568 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-06 02:02:41,461 truncating revision to first 12 chars 2016-05-06 02:02:41,461 Setting DEBUG logging. 2016-05-06 02:02:41,461 attempt 1/10 2016-05-06 02:02:41,461 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9e9cb8b89a10?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-06 02:02:42,487 unpacking tar archive at: fx-team-9e9cb8b89a10/testing/mozharness/ program finished with exit code 0 elapsedTime=2.058756 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-05-06 02:02:43.306155) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 02:02:43.306562) ========= script_repo_revision: 9e9cb8b89a1091c9b9e582c2865a771f9a2a0936 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-06 02:02:43.307067) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 02:02:43.307471) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-06 02:02:43.319455) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-05-06 02:02:43.319782) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=7cf709767345e0a0c5a90e72000001d4-1462525156.380733-2130376568 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:02:43 INFO - MultiFileLogger online at 20160506 02:02:43 in /builds/slave/test 02:02:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 02:02:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:02:43 INFO - {'append_to_log': False, 02:02:43 INFO - 'base_work_dir': '/builds/slave/test', 02:02:43 INFO - 'blob_upload_branch': 'Fx-Team', 02:02:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:02:43 INFO - 'branch': 'Fx-Team', 02:02:43 INFO - 'buildbot_json_path': 'buildprops.json', 02:02:43 INFO - 'config_files': ('talos/linux_config.py',), 02:02:43 INFO - 'default_actions': ('clobber', 02:02:43 INFO - 'read-buildbot-config', 02:02:43 INFO - 'download-and-extract', 02:02:43 INFO - 'populate-webroot', 02:02:43 INFO - 'create-virtualenv', 02:02:43 INFO - 'install', 02:02:43 INFO - 'run-tests'), 02:02:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:02:43 INFO - 'download_minidump_stackwalk': True, 02:02:43 INFO - 'download_symbols': 'ondemand', 02:02:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:02:43 INFO - 'tooltool.py': '/tools/tooltool.py', 02:02:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:02:43 INFO - '/tools/misc-python/virtualenv.py')}, 02:02:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:02:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:02:43 INFO - 'installer_path': 'installer.exe', 02:02:43 INFO - 'log_level': 'info', 02:02:43 INFO - 'log_name': 'talos', 02:02:43 INFO - 'log_to_console': True, 02:02:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:02:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:02:43 INFO - 'opt_config_files': (), 02:02:43 INFO - 'pip_index': False, 02:02:43 INFO - 'sps_profile': False, 02:02:43 INFO - 'sps_profile_interval': 0, 02:02:43 INFO - 'suite': 'dromaeojs-e10s', 02:02:43 INFO - 'system_bits': '32', 02:02:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:02:43 INFO - 'title': 'talos-linux64-ix-024', 02:02:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:02:43 INFO - 'use_talos_json': True, 02:02:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:02:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:02:43 INFO - 'work_dir': 'build'} 02:02:43 INFO - ##### 02:02:43 INFO - ##### Running clobber step. 02:02:43 INFO - ##### 02:02:43 INFO - Running pre-action listener: _resource_record_pre_action 02:02:43 INFO - Running main action method: clobber 02:02:43 INFO - rmtree: /builds/slave/test/build 02:02:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:02:45 INFO - Running post-action listener: _resource_record_post_action 02:02:45 INFO - ##### 02:02:45 INFO - ##### Running read-buildbot-config step. 02:02:45 INFO - ##### 02:02:45 INFO - Running pre-action listener: _resource_record_pre_action 02:02:45 INFO - Running main action method: read_buildbot_config 02:02:45 INFO - Using buildbot properties: 02:02:45 INFO - { 02:02:45 INFO - "project": "", 02:02:45 INFO - "product": "firefox", 02:02:45 INFO - "script_repo_revision": "production", 02:02:45 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 02:02:45 INFO - "repository": "", 02:02:45 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 02:02:45 INFO - "buildid": "20160505233053", 02:02:45 INFO - "pgo_build": "True", 02:02:45 INFO - "basedir": "/builds/slave/test", 02:02:45 INFO - "buildnumber": 727, 02:02:45 INFO - "slavename": "talos-linux64-ix-024", 02:02:45 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:02:45 INFO - "platform": "ubuntu64_hw", 02:02:45 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:02:45 INFO - "branch": "fx-team", 02:02:45 INFO - "repo_path": "integration/fx-team", 02:02:45 INFO - "revision": "9e9cb8b89a1091c9b9e582c2865a771f9a2a0936", 02:02:45 INFO - "stage_platform": "linux64-pgo", 02:02:45 INFO - "builduid": "f4eae97c061745349a9df383ac529b6b", 02:02:45 INFO - "slavebuilddir": "test" 02:02:45 INFO - } 02:02:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/fnlcXiXnTKihk3YFUTwXRw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 02:02:45 INFO - Running post-action listener: _resource_record_post_action 02:02:45 INFO - ##### 02:02:45 INFO - ##### Running download-and-extract step. 02:02:45 INFO - ##### 02:02:45 INFO - Running pre-action listener: _resource_record_pre_action 02:02:45 INFO - Running main action method: download_and_extract 02:02:45 INFO - mkdir: /builds/slave/test/build/tests 02:02: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')]} 02:02:45 INFO - https://queue.taskcluster.net/v1/task/fnlcXiXnTKihk3YFUTwXRw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:02:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fnlcXiXnTKihk3YFUTwXRw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:02:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fnlcXiXnTKihk3YFUTwXRw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:02:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fnlcXiXnTKihk3YFUTwXRw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:02:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fnlcXiXnTKihk3YFUTwXRw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:02:54 INFO - Downloaded 1361 bytes. 02:02:54 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 02:02:54 INFO - Using the following test package requirements: 02:02:54 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 02:02:54 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:02:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:02:54 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:02:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:02:54 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:02:54 INFO - u'jsshell-linux-x86_64.zip'], 02:02:54 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:02:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:02:54 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 02:02:54 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:02:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:02:54 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:02:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:02:54 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:02:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:02:54 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 02:02:54 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:02:54 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:02: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')]} 02:02:54 INFO - https://queue.taskcluster.net/v1/task/fnlcXiXnTKihk3YFUTwXRw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:02:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fnlcXiXnTKihk3YFUTwXRw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:02:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fnlcXiXnTKihk3YFUTwXRw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:02:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fnlcXiXnTKihk3YFUTwXRw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:02:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fnlcXiXnTKihk3YFUTwXRw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:03:05 INFO - Downloaded 23894075 bytes. 02:03:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:03:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:03:07 INFO - Return code: 0 02:03:07 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:03:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:03:07 INFO - https://queue.taskcluster.net/v1/task/fnlcXiXnTKihk3YFUTwXRw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:03:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fnlcXiXnTKihk3YFUTwXRw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:03:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fnlcXiXnTKihk3YFUTwXRw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:03:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fnlcXiXnTKihk3YFUTwXRw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 02:03:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fnlcXiXnTKihk3YFUTwXRw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:03:08 INFO - Downloaded 23894075 bytes. 02:03:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:03:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:03:09 INFO - Return code: 0 02:03: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')]} 02:03:09 INFO - https://queue.taskcluster.net/v1/task/fnlcXiXnTKihk3YFUTwXRw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:03:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fnlcXiXnTKihk3YFUTwXRw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:03:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fnlcXiXnTKihk3YFUTwXRw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:03:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fnlcXiXnTKihk3YFUTwXRw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 02:03:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fnlcXiXnTKihk3YFUTwXRw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:03:10 INFO - Downloaded 10840152 bytes. 02:03:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:03:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:03:11 INFO - Return code: 0 02:03:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:03:11 INFO - https://queue.taskcluster.net/v1/task/fnlcXiXnTKihk3YFUTwXRw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:03:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fnlcXiXnTKihk3YFUTwXRw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:03:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fnlcXiXnTKihk3YFUTwXRw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:03:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fnlcXiXnTKihk3YFUTwXRw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:03:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fnlcXiXnTKihk3YFUTwXRw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:03:12 INFO - Downloaded 58394309 bytes. 02:03:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fnlcXiXnTKihk3YFUTwXRw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:03:12 INFO - mkdir: /builds/slave/test/properties 02:03:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:03:12 INFO - Writing to file /builds/slave/test/properties/build_url 02:03:12 INFO - Contents: 02:03:12 INFO - build_url:https://queue.taskcluster.net/v1/task/fnlcXiXnTKihk3YFUTwXRw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 02:03:13 INFO - Running post-action listener: _resource_record_post_action 02:03:13 INFO - Running post-action listener: set_extra_try_arguments 02:03:13 INFO - ##### 02:03:13 INFO - ##### Running populate-webroot step. 02:03:13 INFO - ##### 02:03:13 INFO - Running pre-action listener: _resource_record_pre_action 02:03:13 INFO - Running main action method: populate_webroot 02:03:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:03:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:03:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:03:13 INFO - '--tppagecycles', 02:03:13 INFO - '7'], 02:03:13 INFO - 'tests': ['tsvgm']}}, 02:03:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:03:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:03:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:03:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:03:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:03:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:03:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:03:13 INFO - 'talos_options': ['--disable-e10s'], 02:03:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:03:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:03:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:03:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:03:13 INFO - 'talos_options': ['--disable-e10s'], 02:03:13 INFO - 'tests': ['damp', 'tps']}, 02:03:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:03:13 INFO - 'tests': ['damp', 'tps']}, 02:03:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:03:13 INFO - 'tests': ['dromaeo_dom']}, 02:03:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:03:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:03:13 INFO - 'tests': ['a11yr', 02:03:13 INFO - 'ts_paint', 02:03:13 INFO - 'tpaint', 02:03:13 INFO - 'sessionrestore', 02:03:13 INFO - 'sessionrestore_no_auto_restore', 02:03:13 INFO - 'tabpaint']}, 02:03:13 INFO - 'other-e10s': {'tests': ['a11yr', 02:03:13 INFO - 'ts_paint', 02:03:13 INFO - 'tpaint', 02:03:13 INFO - 'sessionrestore', 02:03:13 INFO - 'sessionrestore_no_auto_restore', 02:03:13 INFO - 'tabpaint']}, 02:03:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:03:13 INFO - 'ts_paint', 02:03:13 INFO - 'tpaint', 02:03:13 INFO - 'sessionrestore', 02:03:13 INFO - 'sessionrestore_no_auto_restore', 02:03:13 INFO - 'tabpaint']}, 02:03:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:03:13 INFO - 'ts_paint', 02:03:13 INFO - 'tpaint', 02:03:13 INFO - 'sessionrestore', 02:03:13 INFO - 'sessionrestore_no_auto_restore', 02:03:13 INFO - 'tabpaint']}, 02:03:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:03:13 INFO - 'tests': ['a11yr', 02:03:13 INFO - 'ts_paint', 02:03:13 INFO - 'tpaint', 02:03:13 INFO - 'sessionrestore', 02:03:13 INFO - 'sessionrestore_no_auto_restore', 02:03:13 INFO - 'tabpaint']}, 02:03:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:03:13 INFO - 'tests': ['a11yr', 02:03:13 INFO - 'ts_paint', 02:03:13 INFO - 'tpaint', 02:03:13 INFO - 'sessionrestore', 02:03:13 INFO - 'sessionrestore_no_auto_restore', 02:03:13 INFO - 'tabpaint']}, 02:03:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:03:13 INFO - 'tests': ['tsvgx', 02:03:13 INFO - 'tsvgr_opacity', 02:03:13 INFO - 'tart', 02:03:13 INFO - 'tscrollx', 02:03:13 INFO - 'cart']}, 02:03:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:03:13 INFO - 'tsvgr_opacity', 02:03:13 INFO - 'tart', 02:03:13 INFO - 'tscrollx', 02:03:13 INFO - 'cart']}, 02:03:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:03:13 INFO - 'talos_options': ['--disable-e10s'], 02:03:13 INFO - 'tests': ['tp5o']}, 02:03:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:03:13 INFO - 'tests': ['tp5o']}, 02:03:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:03:13 INFO - 'talos_options': ['--disable-e10s', 02:03:13 INFO - '--xperf_path', 02:03:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:03:13 INFO - 'tests': ['tp5n']}, 02:03:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:03:13 INFO - 'talos_options': ['--xperf_path', 02:03:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:03:13 INFO - 'tests': ['tp5n']}}, 02:03:13 INFO - 'talos.zip': {'path': '', 02:03:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:03:13 INFO - Running post-action listener: _resource_record_post_action 02:03:13 INFO - ##### 02:03:13 INFO - ##### Running create-virtualenv step. 02:03:13 INFO - ##### 02:03:13 INFO - Running pre-action listener: _resource_record_pre_action 02:03:13 INFO - Running main action method: create_virtualenv 02:03:13 INFO - Creating virtualenv /builds/slave/test/build/venv 02:03:13 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:03:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:03:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:03:13 INFO - Using real prefix '/usr' 02:03:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:03:14 INFO - Installing distribute.............................................................................................................................................................................................done. 02:03:16 INFO - Installing pip.................done. 02:03:16 INFO - Return code: 0 02:03:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:03: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')]} 02:03:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:03:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03: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')]} 02:03:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:03:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2f2250f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e9410>, '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 0x17ea310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ea7a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1462525156.380733-2130376568', '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 02:03: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', 'pip>=1.5'] in /builds/slave/test/build 02:03: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 pip>=1.5 02:03:16 INFO - Using env: {'DISPLAY': ':0', 02:03:16 INFO - 'HOME': '/home/cltbld', 02:03:16 INFO - 'LANG': 'en_US.UTF-8', 02:03:16 INFO - 'LANGUAGE': 'en_US:en', 02:03:16 INFO - 'LOGNAME': 'cltbld', 02:03:16 INFO - 'MAIL': '/var/mail/cltbld', 02:03:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:03:16 INFO - 'MOZ_NO_REMOTE': '1', 02:03:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:03:16 INFO - 'NO_EM_RESTART': '1', 02:03:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:03:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:03:16 INFO - 'PWD': '/builds/slave/test', 02:03:16 INFO - 'SHELL': '/bin/bash', 02:03:16 INFO - 'SHLVL': '1', 02:03:16 INFO - 'TERM': 'linux', 02:03:16 INFO - 'TMOUT': '86400', 02:03:16 INFO - 'USER': 'cltbld', 02:03:16 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1462525156.380733-2130376568', 02:03:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:03:16 INFO - '_': '/tools/buildbot/bin/python'} 02:03:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:03:16 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:03:16 INFO - Cleaning up... 02:03:16 INFO - Return code: 0 02:03:16 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:03: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')]} 02:03:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:03:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03: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')]} 02:03:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:03:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2f2250f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e9410>, '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 0x17ea310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ea7a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1462525156.380733-2130376568', '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 02:03:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 02:03:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:03:16 INFO - Using env: {'DISPLAY': ':0', 02:03:16 INFO - 'HOME': '/home/cltbld', 02:03:16 INFO - 'LANG': 'en_US.UTF-8', 02:03:16 INFO - 'LANGUAGE': 'en_US:en', 02:03:16 INFO - 'LOGNAME': 'cltbld', 02:03:16 INFO - 'MAIL': '/var/mail/cltbld', 02:03:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:03:16 INFO - 'MOZ_NO_REMOTE': '1', 02:03:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:03:16 INFO - 'NO_EM_RESTART': '1', 02:03:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:03:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:03:16 INFO - 'PWD': '/builds/slave/test', 02:03:16 INFO - 'SHELL': '/bin/bash', 02:03:16 INFO - 'SHLVL': '1', 02:03:16 INFO - 'TERM': 'linux', 02:03:16 INFO - 'TMOUT': '86400', 02:03:16 INFO - 'USER': 'cltbld', 02:03:16 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1462525156.380733-2130376568', 02:03:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:03:16 INFO - '_': '/tools/buildbot/bin/python'} 02:03:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:03:16 INFO - Downloading/unpacking psutil>=0.7.1 02:03:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:03:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:03:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:03:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:03:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:03:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:03:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:03:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:03:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:03:18 INFO - Installing collected packages: psutil 02:03:18 INFO - Running setup.py install for psutil 02:03:18 INFO - building 'psutil._psutil_linux' extension 02:03:18 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:03:19 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 02:03:19 INFO - building 'psutil._psutil_posix' extension 02:03:19 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 02:03:19 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 02:03:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:03:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:03:19 INFO - Successfully installed psutil 02:03:19 INFO - Cleaning up... 02:03:20 INFO - Return code: 0 02:03:20 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:03:20 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')]} 02:03:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:03:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03:20 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')]} 02:03:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:03:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03:20 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 0x7fb2f2250f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e9410>, '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 0x17ea310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ea7a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1462525156.380733-2130376568', '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 02:03:20 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 02:03:20 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 02:03:20 INFO - Using env: {'DISPLAY': ':0', 02:03:20 INFO - 'HOME': '/home/cltbld', 02:03:20 INFO - 'LANG': 'en_US.UTF-8', 02:03:20 INFO - 'LANGUAGE': 'en_US:en', 02:03:20 INFO - 'LOGNAME': 'cltbld', 02:03:20 INFO - 'MAIL': '/var/mail/cltbld', 02:03:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:03:20 INFO - 'MOZ_NO_REMOTE': '1', 02:03:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:03:20 INFO - 'NO_EM_RESTART': '1', 02:03:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:03:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:03:20 INFO - 'PWD': '/builds/slave/test', 02:03:20 INFO - 'SHELL': '/bin/bash', 02:03:20 INFO - 'SHLVL': '1', 02:03:20 INFO - 'TERM': 'linux', 02:03:20 INFO - 'TMOUT': '86400', 02:03:20 INFO - 'USER': 'cltbld', 02:03:20 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1462525156.380733-2130376568', 02:03:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:03:20 INFO - '_': '/tools/buildbot/bin/python'} 02:03:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:03:20 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:03:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:03:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:03:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:03:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:03:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:03:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:03:22 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:03:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:03:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:03:22 INFO - Installing collected packages: mozsystemmonitor 02:03:22 INFO - Running setup.py install for mozsystemmonitor 02:03:22 INFO - Successfully installed mozsystemmonitor 02:03:22 INFO - Cleaning up... 02:03:22 INFO - Return code: 0 02:03:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:03:22 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')]} 02:03:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:03:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03:22 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')]} 02:03:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:03:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03:22 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 0x7fb2f2250f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e9410>, '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 0x17ea310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ea7a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1462525156.380733-2130376568', '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 02:03:22 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 02:03:22 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 02:03:22 INFO - Using env: {'DISPLAY': ':0', 02:03:22 INFO - 'HOME': '/home/cltbld', 02:03:22 INFO - 'LANG': 'en_US.UTF-8', 02:03:22 INFO - 'LANGUAGE': 'en_US:en', 02:03:22 INFO - 'LOGNAME': 'cltbld', 02:03:22 INFO - 'MAIL': '/var/mail/cltbld', 02:03:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:03:22 INFO - 'MOZ_NO_REMOTE': '1', 02:03:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:03:22 INFO - 'NO_EM_RESTART': '1', 02:03:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:03:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:03:22 INFO - 'PWD': '/builds/slave/test', 02:03:22 INFO - 'SHELL': '/bin/bash', 02:03:22 INFO - 'SHLVL': '1', 02:03:22 INFO - 'TERM': 'linux', 02:03:22 INFO - 'TMOUT': '86400', 02:03:22 INFO - 'USER': 'cltbld', 02:03:22 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1462525156.380733-2130376568', 02:03:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:03:22 INFO - '_': '/tools/buildbot/bin/python'} 02:03:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:03:22 INFO - Downloading/unpacking blobuploader==1.2.4 02:03:22 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 02:03:22 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 02:03:22 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 02:03:22 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 02:03:22 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 02:03:22 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 02:03:24 INFO - Downloading blobuploader-1.2.4.tar.gz 02:03:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:03:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:03:24 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 02:03:24 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 02:03:24 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 02:03:24 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 02:03:24 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 02:03:24 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 02:03:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:03:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:03:24 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 02:03:24 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 02:03:24 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 02:03:24 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 02:03:24 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 02:03:24 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 02:03:25 INFO - Downloading docopt-0.6.1.tar.gz 02:03:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:03:25 INFO - Installing collected packages: blobuploader, requests, docopt 02:03:25 INFO - Running setup.py install for blobuploader 02:03:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:03:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:03:25 INFO - Running setup.py install for requests 02:03:25 INFO - Running setup.py install for docopt 02:03:25 INFO - Successfully installed blobuploader requests docopt 02:03:25 INFO - Cleaning up... 02:03:25 INFO - Return code: 0 02:03:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:03:25 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')]} 02:03:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:03:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03:25 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')]} 02:03:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:03:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03:25 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 0x7fb2f2250f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e9410>, '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 0x17ea310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ea7a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1462525156.380733-2130376568', '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 02:03:25 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 02:03:25 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 02:03:25 INFO - Using env: {'DISPLAY': ':0', 02:03:25 INFO - 'HOME': '/home/cltbld', 02:03:25 INFO - 'LANG': 'en_US.UTF-8', 02:03:25 INFO - 'LANGUAGE': 'en_US:en', 02:03:25 INFO - 'LOGNAME': 'cltbld', 02:03:25 INFO - 'MAIL': '/var/mail/cltbld', 02:03:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:03:25 INFO - 'MOZ_NO_REMOTE': '1', 02:03:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:03:25 INFO - 'NO_EM_RESTART': '1', 02:03:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:03:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:03:25 INFO - 'PWD': '/builds/slave/test', 02:03:25 INFO - 'SHELL': '/bin/bash', 02:03:25 INFO - 'SHLVL': '1', 02:03:25 INFO - 'TERM': 'linux', 02:03:25 INFO - 'TMOUT': '86400', 02:03:25 INFO - 'USER': 'cltbld', 02:03:25 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1462525156.380733-2130376568', 02:03:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:03:25 INFO - '_': '/tools/buildbot/bin/python'} 02:03:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:03:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:03:25 INFO - Running setup.py (path:/tmp/pip-GXJPf7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:03:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:03:26 INFO - Running setup.py (path:/tmp/pip-HlT0tf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:03:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:03:26 INFO - Running setup.py (path:/tmp/pip-plaT3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:03:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:03:26 INFO - Running setup.py (path:/tmp/pip-Iy6VRj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:03:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:03:26 INFO - Running setup.py (path:/tmp/pip-LRIFzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:03:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:03:26 INFO - Running setup.py (path:/tmp/pip-AGmf1i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:03:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:03:26 INFO - Running setup.py (path:/tmp/pip-5mGM0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:03:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:03:26 INFO - Running setup.py (path:/tmp/pip-qp2Xee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:03:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:03:26 INFO - Running setup.py (path:/tmp/pip-fC3ViH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:03:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:03:26 INFO - Running setup.py (path:/tmp/pip-A7sBmf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:03:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:03:26 INFO - Running setup.py (path:/tmp/pip-q7zisb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:03:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:03:26 INFO - Running setup.py (path:/tmp/pip-VHJUOl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:03:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:03:26 INFO - Running setup.py (path:/tmp/pip-h3nkpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:03:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:03:26 INFO - Running setup.py (path:/tmp/pip-MElhOD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:03:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:03:26 INFO - Running setup.py (path:/tmp/pip-O6ghLe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:03:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:03:27 INFO - Running setup.py (path:/tmp/pip-GtDXM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:03:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:03:27 INFO - Running setup.py (path:/tmp/pip-rBJcmo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:03:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:03:27 INFO - Running setup.py install for manifestparser 02:03:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:03:27 INFO - Running setup.py install for mozcrash 02:03:27 INFO - Running setup.py install for mozdebug 02:03:27 INFO - Running setup.py install for mozdevice 02:03:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:03:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:03:27 INFO - Running setup.py install for mozfile 02:03:27 INFO - Running setup.py install for mozhttpd 02:03:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:03:27 INFO - Running setup.py install for mozinfo 02:03:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:03:27 INFO - Running setup.py install for mozInstall 02:03:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:03:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:03:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:03:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:03:27 INFO - Running setup.py install for mozleak 02:03:28 INFO - Running setup.py install for mozlog 02:03:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:03:28 INFO - Running setup.py install for moznetwork 02:03:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:03:28 INFO - Running setup.py install for mozprocess 02:03:28 INFO - Running setup.py install for mozprofile 02:03:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:03:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:03:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:03:28 INFO - Running setup.py install for mozrunner 02:03:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:03:28 INFO - Running setup.py install for mozscreenshot 02:03:28 INFO - Running setup.py install for moztest 02:03:28 INFO - Running setup.py install for mozversion 02:03:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:03:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:03:28 INFO - Cleaning up... 02:03:28 INFO - Return code: 0 02:03:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:03:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:03:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:03:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:03:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:03:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03:28 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 0x7fb2f2250f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e9410>, '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 0x17ea310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ea7a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1462525156.380733-2130376568', '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 02:03:28 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 02:03:28 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 02:03:28 INFO - Using env: {'DISPLAY': ':0', 02:03:28 INFO - 'HOME': '/home/cltbld', 02:03:28 INFO - 'LANG': 'en_US.UTF-8', 02:03:28 INFO - 'LANGUAGE': 'en_US:en', 02:03:28 INFO - 'LOGNAME': 'cltbld', 02:03:28 INFO - 'MAIL': '/var/mail/cltbld', 02:03:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:03:28 INFO - 'MOZ_NO_REMOTE': '1', 02:03:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:03:28 INFO - 'NO_EM_RESTART': '1', 02:03:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:03:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:03:28 INFO - 'PWD': '/builds/slave/test', 02:03:28 INFO - 'SHELL': '/bin/bash', 02:03:28 INFO - 'SHLVL': '1', 02:03:28 INFO - 'TERM': 'linux', 02:03:28 INFO - 'TMOUT': '86400', 02:03:28 INFO - 'USER': 'cltbld', 02:03:28 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1462525156.380733-2130376568', 02:03:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:03:28 INFO - '_': '/tools/buildbot/bin/python'} 02:03:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:03:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:03:29 INFO - Running setup.py (path:/tmp/pip-qKNa6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:03:29 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)) 02:03:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:03:29 INFO - Running setup.py (path:/tmp/pip-WfeQnV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:03:29 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)) 02:03:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:03:29 INFO - Running setup.py (path:/tmp/pip-qEtO0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:03:29 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)) 02:03:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:03:29 INFO - Running setup.py (path:/tmp/pip-26sWTN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:03:29 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)) 02:03:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:03:29 INFO - Running setup.py (path:/tmp/pip-vNP1S3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:03:29 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)) 02:03:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:03:29 INFO - Running setup.py (path:/tmp/pip-wX9eKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:03:29 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)) 02:03:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:03:29 INFO - Running setup.py (path:/tmp/pip-vHT6zA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:03:29 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)) 02:03:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:03:29 INFO - Running setup.py (path:/tmp/pip-LLMUFs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:03:29 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)) 02:03:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:03:29 INFO - Running setup.py (path:/tmp/pip-9Cs4ae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:03:29 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)) 02:03:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:03:29 INFO - Running setup.py (path:/tmp/pip-OgVJkR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:03:29 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)) 02:03:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:03:29 INFO - Running setup.py (path:/tmp/pip-gsBb5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:03:29 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)) 02:03:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:03:29 INFO - Running setup.py (path:/tmp/pip-lXdShm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:03:30 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)) 02:03:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:03:30 INFO - Running setup.py (path:/tmp/pip-Ia12bP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:03:30 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)) 02:03:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:03:30 INFO - Running setup.py (path:/tmp/pip-hJA901-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:03:30 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)) 02:03:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:03:30 INFO - Running setup.py (path:/tmp/pip-A_Yz7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:03:30 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)) 02:03:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:03:30 INFO - Running setup.py (path:/tmp/pip-n8l6wS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:03:30 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)) 02:03:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:03:30 INFO - Running setup.py (path:/tmp/pip-zdSwS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:03:30 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)) 02:03:30 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)) 02:03:30 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)) 02:03:30 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)) 02:03:30 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)) 02:03:30 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)) 02:03:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:03:30 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 02:03:30 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 02:03:30 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 02:03:30 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 02:03:30 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 02:03:30 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 02:03:32 INFO - Downloading blessings-1.6.tar.gz 02:03:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:03:32 INFO - Installing collected packages: blessings 02:03:32 INFO - Running setup.py install for blessings 02:03:32 INFO - Successfully installed blessings 02:03:32 INFO - Cleaning up... 02:03:32 INFO - Return code: 0 02:03:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:03:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:03:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:03:32 INFO - Reading from file tmpfile_stdout 02:03:32 INFO - Current package versions: 02:03:32 INFO - argparse == 1.2.1 02:03:32 INFO - blessings == 1.6 02:03:32 INFO - blobuploader == 1.2.4 02:03:32 INFO - docopt == 0.6.1 02:03:32 INFO - manifestparser == 1.1 02:03:32 INFO - mozInstall == 1.12 02:03:32 INFO - mozcrash == 0.17 02:03:32 INFO - mozdebug == 0.1 02:03:32 INFO - mozdevice == 0.48 02:03:32 INFO - mozfile == 1.2 02:03:32 INFO - mozhttpd == 0.7 02:03:32 INFO - mozinfo == 0.9 02:03:32 INFO - mozleak == 0.1 02:03:32 INFO - mozlog == 3.1 02:03:32 INFO - moznetwork == 0.27 02:03:32 INFO - mozprocess == 0.22 02:03:32 INFO - mozprofile == 0.28 02:03:32 INFO - mozrunner == 6.11 02:03:32 INFO - mozscreenshot == 0.1 02:03:32 INFO - mozsystemmonitor == 0.0 02:03:32 INFO - moztest == 0.7 02:03:32 INFO - mozversion == 1.4 02:03:32 INFO - psutil == 3.1.1 02:03:32 INFO - requests == 1.2.3 02:03:32 INFO - wsgiref == 0.1.2 02:03:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:03:32 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')]} 02:03:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:03:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03:32 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')]} 02:03:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:03:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03:32 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 0x7fb2f2250f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e9410>, '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 0x17ea310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ea7a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1462525156.380733-2130376568', '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 02:03:32 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 02:03:32 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 02:03:32 INFO - Using env: {'DISPLAY': ':0', 02:03:32 INFO - 'HOME': '/home/cltbld', 02:03:32 INFO - 'LANG': 'en_US.UTF-8', 02:03:32 INFO - 'LANGUAGE': 'en_US:en', 02:03:32 INFO - 'LOGNAME': 'cltbld', 02:03:32 INFO - 'MAIL': '/var/mail/cltbld', 02:03:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:03:32 INFO - 'MOZ_NO_REMOTE': '1', 02:03:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:03:32 INFO - 'NO_EM_RESTART': '1', 02:03:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:03:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:03:32 INFO - 'PWD': '/builds/slave/test', 02:03:32 INFO - 'SHELL': '/bin/bash', 02:03:32 INFO - 'SHLVL': '1', 02:03:32 INFO - 'TERM': 'linux', 02:03:32 INFO - 'TMOUT': '86400', 02:03:32 INFO - 'USER': 'cltbld', 02:03:32 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1462525156.380733-2130376568', 02:03:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:03:32 INFO - '_': '/tools/buildbot/bin/python'} 02:03:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:03:32 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)) 02:03:32 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)) 02:03:32 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)) 02:03:32 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)) 02:03:32 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)) 02:03:32 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)) 02:03:32 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)) 02:03:32 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)) 02:03:32 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)) 02:03:32 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)) 02:03:32 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)) 02:03:32 INFO - Cleaning up... 02:03:32 INFO - Return code: 0 02:03:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:03:32 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')]} 02:03:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:03:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03:32 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')]} 02:03:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:03:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03:32 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 0x7fb2f2250f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e9410>, '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 0x17ea310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ea7a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1462525156.380733-2130376568', '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 02:03:32 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 02:03:32 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 02:03:32 INFO - Using env: {'DISPLAY': ':0', 02:03:32 INFO - 'HOME': '/home/cltbld', 02:03:32 INFO - 'LANG': 'en_US.UTF-8', 02:03:32 INFO - 'LANGUAGE': 'en_US:en', 02:03:32 INFO - 'LOGNAME': 'cltbld', 02:03:32 INFO - 'MAIL': '/var/mail/cltbld', 02:03:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:03:32 INFO - 'MOZ_NO_REMOTE': '1', 02:03:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:03:32 INFO - 'NO_EM_RESTART': '1', 02:03:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:03:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:03:32 INFO - 'PWD': '/builds/slave/test', 02:03:32 INFO - 'SHELL': '/bin/bash', 02:03:32 INFO - 'SHLVL': '1', 02:03:32 INFO - 'TERM': 'linux', 02:03:32 INFO - 'TMOUT': '86400', 02:03:32 INFO - 'USER': 'cltbld', 02:03:32 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1462525156.380733-2130376568', 02:03:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:03:32 INFO - '_': '/tools/buildbot/bin/python'} 02:03:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:03:33 INFO - Downloading/unpacking jsonschema 02:03:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:03:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:03:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:03:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:03:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:03:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:03:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:03:35 INFO - Downloading/unpacking functools32 (from jsonschema) 02:03:35 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 02:03:35 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 02:03:35 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 02:03:35 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 02:03:35 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 02:03:35 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 02:03:35 INFO - Downloading functools32-3.2.3-2.tar.gz 02:03:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:03:35 INFO - warning: no files found matching '*.txt' 02:03:35 INFO - no previously-included directories found matching 'build' 02:03:35 INFO - no previously-included directories found matching 'dist' 02:03:35 INFO - no previously-included directories found matching '.git*' 02:03:35 INFO - Installing collected packages: jsonschema, functools32 02:03:35 INFO - Running setup.py install for functools32 02:03:35 INFO - warning: no files found matching '*.txt' 02:03:35 INFO - no previously-included directories found matching 'build' 02:03:35 INFO - no previously-included directories found matching 'dist' 02:03:35 INFO - no previously-included directories found matching '.git*' 02:03:35 INFO - Successfully installed jsonschema functools32 02:03:35 INFO - Cleaning up... 02:03:35 INFO - Return code: 0 02:03:35 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:03:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:03:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:03:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:03:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:03:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:03:35 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 0x7fb2f2250f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175a5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e9410>, '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 0x17ea310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ea7a0>, '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': '7cf709767345e0a0c5a90e72000001d4-1462525156.380733-2130376568', '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 02:03:35 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 02:03:35 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 02:03:35 INFO - Using env: {'DISPLAY': ':0', 02:03:35 INFO - 'HOME': '/home/cltbld', 02:03:35 INFO - 'LANG': 'en_US.UTF-8', 02:03:35 INFO - 'LANGUAGE': 'en_US:en', 02:03:35 INFO - 'LOGNAME': 'cltbld', 02:03:35 INFO - 'MAIL': '/var/mail/cltbld', 02:03:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:03:35 INFO - 'MOZ_NO_REMOTE': '1', 02:03:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:03:35 INFO - 'NO_EM_RESTART': '1', 02:03:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:03:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:03:35 INFO - 'PWD': '/builds/slave/test', 02:03:35 INFO - 'SHELL': '/bin/bash', 02:03:35 INFO - 'SHLVL': '1', 02:03:35 INFO - 'TERM': 'linux', 02:03:35 INFO - 'TMOUT': '86400', 02:03:35 INFO - 'USER': 'cltbld', 02:03:35 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1462525156.380733-2130376568', 02:03:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:03:35 INFO - '_': '/tools/buildbot/bin/python'} 02:03:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:03:35 INFO - Downloading/unpacking flake8 02:03:35 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 02:03:35 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 02:03:35 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 02:03:35 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 02:03:35 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 02:03:35 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 02:03:37 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:03:37 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:03:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:03:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:03:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:03:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:03:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:03:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:03:37 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:03:37 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:03:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:03:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:03:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:03:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:03:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:03:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:03:38 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:03:38 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 02:03:38 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 02:03:38 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 02:03:38 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 02:03:38 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 02:03:38 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 02:03:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:03:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:03:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:03:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:03:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:03:38 INFO - no previously-included directories found matching 'docs/_build' 02:03:38 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:03:38 INFO - Running setup.py install for pep8 02:03:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:03:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:03:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:03:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:03:38 INFO - no previously-included directories found matching 'docs/_build' 02:03:38 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:03:38 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:03:38 INFO - Cleaning up... 02:03:38 INFO - Return code: 0 02:03:38 INFO - Running post-action listener: _resource_record_post_action 02:03:38 INFO - Running post-action listener: _start_resource_monitoring 02:03:38 INFO - Starting resource monitoring. 02:03:38 INFO - ##### 02:03:38 INFO - ##### Running install step. 02:03:38 INFO - ##### 02:03:38 INFO - Running pre-action listener: _resource_record_pre_action 02:03:38 INFO - Running main action method: install 02:03:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:03:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:03:38 INFO - Reading from file tmpfile_stdout 02:03:38 INFO - Detecting whether we're running mozinstall >=1.0... 02:03:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:03:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:03:38 INFO - Reading from file tmpfile_stdout 02:03:38 INFO - Output received: 02:03:38 INFO - Usage: mozinstall [options] installer 02:03:38 INFO - Options: 02:03:38 INFO - -h, --help show this help message and exit 02:03:38 INFO - -d DEST, --destination=DEST 02:03:38 INFO - Directory to install application into. [default: 02:03:38 INFO - "/builds/slave/test"] 02:03:38 INFO - --app=APP Application being installed. [default: firefox] 02:03:38 INFO - mkdir: /builds/slave/test/build/application 02:03:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:03:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:03:55 INFO - Reading from file tmpfile_stdout 02:03:55 INFO - Output received: 02:03:55 INFO - /builds/slave/test/build/application/firefox/firefox 02:03:55 INFO - Running post-action listener: _resource_record_post_action 02:03:55 INFO - ##### 02:03:55 INFO - ##### Running run-tests step. 02:03:55 INFO - ##### 02:03:55 INFO - Running pre-action listener: _resource_record_pre_action 02:03:55 INFO - Running main action method: run_tests 02:03:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:03:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:03:55 INFO - Python 2.7.3 02:03:55 INFO - Return code: 0 02:03:55 INFO - grabbing minidump binary from tooltool 02:03:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:03:55 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 0x17e9410>, '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 0x17ea310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17ea7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:03:55 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 02:03:55 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 02:03:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:03:55 INFO - Return code: 0 02:03:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:03:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:03:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:03:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:03:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:03:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:03:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:03:56 INFO - Return code: 0 02:03:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fnlcXiXnTKihk3YFUTwXRw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 02:03:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fnlcXiXnTKihk3YFUTwXRw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --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 02:03:56 INFO - Using env: {'DISPLAY': ':0', 02:03:56 INFO - 'HOME': '/home/cltbld', 02:03:56 INFO - 'LANG': 'en_US.UTF-8', 02:03:56 INFO - 'LANGUAGE': 'en_US:en', 02:03:56 INFO - 'LOGNAME': 'cltbld', 02:03:56 INFO - 'MAIL': '/var/mail/cltbld', 02:03:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:03:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:03:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:03:56 INFO - 'MOZ_NO_REMOTE': '1', 02:03:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:03:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:03:56 INFO - 'NO_EM_RESTART': '1', 02:03:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:03:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:03:56 INFO - 'PWD': '/builds/slave/test', 02:03:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:03:56 INFO - 'SHELL': '/bin/bash', 02:03:56 INFO - 'SHLVL': '1', 02:03:56 INFO - 'TERM': 'linux', 02:03:56 INFO - 'TMOUT': '86400', 02:03:56 INFO - 'USER': 'cltbld', 02:03:56 INFO - 'XDG_SESSION_COOKIE': '7cf709767345e0a0c5a90e72000001d4-1462525156.380733-2130376568', 02:03:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:03:56 INFO - '_': '/tools/buildbot/bin/python'} 02:03:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fnlcXiXnTKihk3YFUTwXRw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 02:03:56 INFO - mozversion application_buildid: 20160505233053 02:03:56 INFO - mozversion application_changeset: 9e9cb8b89a1091c9b9e582c2865a771f9a2a0936 02:03:56 INFO - mozversion application_display_name: Nightly 02:03:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:03:56 INFO - mozversion application_name: Firefox 02:03:56 INFO - mozversion application_remotingname: firefox 02:03:56 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:03:56 INFO - mozversion application_vendor: Mozilla 02:03:56 INFO - mozversion application_version: 49.0a1 02:03:56 INFO - mozversion platform_buildid: 20160505233053 02:03:56 INFO - mozversion platform_changeset: 9e9cb8b89a1091c9b9e582c2865a771f9a2a0936 02:03:56 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:03:56 INFO - mozversion platform_version: 49.0a1 02:03:56 INFO - using testdate: 1462525436 02:03:56 INFO - actual date: 1462525436 02:03:56 INFO - starting webserver on 'localhost:33413' 02:03:56 INFO - SUITE-START | Running 2 tests 02:03:56 INFO - TEST-START | dromaeo_css 02:03:56 INFO - operating with platform_type : linux_ 02:03:56 INFO - Initialising browser for dromaeo_css test... 02:03:56 INFO - TEST-INFO | started process 3333 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoL21uL/profile http://localhost:33413/getInfo.html) 02:04:01 INFO - PROCESS | 3333 | 02:04:01 INFO - PROCESS | 3333 | (process:3405): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:04:02 INFO - PROCESS | 3333 | __metrics Screen width/height:1600/1200 02:04:02 INFO - PROCESS | 3333 | colorDepth:24 02:04:02 INFO - PROCESS | 3333 | Browser inner width/height: 1024/697 02:04:02 INFO - PROCESS | 3333 | __metrics 02:04:04 ERROR - PROCESS | 3333 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 02:04:04 INFO - TEST-INFO | 3333: exit 0 02:04:04 INFO - Browser initialized. 02:04:04 INFO - Running cycle 1/1 for dromaeo_css test... 02:04:04 INFO - TEST-INFO | started process 3458 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoL21uL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:04:06 INFO - PROCESS | 3458 | 02:04:06 INFO - PROCESS | 3458 | (process:3521): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:04:16 INFO - PROCESS | 3458 | RSS: Main: 163209216 02:04:16 INFO - PROCESS | 3458 | 02:05:06 INFO - PROCESS | 3458 | 1462525506321 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] 02:07:13 INFO - PROCESS | 3458 | Cycle 1(1): loaded http://localhost:33413/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33413/tests/dromaeo/cssquery-ext.html) 02:07:14 INFO - PROCESS | 3458 | RSS: Main: 167317504 02:07:14 INFO - PROCESS | 3458 | 02:10:16 INFO - PROCESS | 3458 | Cycle 1(1): loaded http://localhost:33413/tests/dromaeo/cssquery-ext.html (next: http://localhost:33413/tests/dromaeo/cssquery-jquery.html) 02:10:17 INFO - PROCESS | 3458 | RSS: Main: 166367232 02:10:17 INFO - PROCESS | 3458 | 02:13:19 INFO - PROCESS | 3458 | Cycle 1(1): loaded http://localhost:33413/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33413/tests/dromaeo/cssquery-mootools.html) 02:13:19 INFO - PROCESS | 3458 | RSS: Main: 167284736 02:13:19 INFO - PROCESS | 3458 | 02:16:21 INFO - PROCESS | 3458 | Cycle 1(1): loaded http://localhost:33413/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33413/tests/dromaeo/cssquery-prototype.html) 02:16:22 INFO - PROCESS | 3458 | RSS: Main: 164745216 02:16:22 INFO - PROCESS | 3458 | 02:19:24 INFO - PROCESS | 3458 | Cycle 1(1): loaded http://localhost:33413/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33413/tests/dromaeo/cssquery-yui.html) 02:19:25 INFO - PROCESS | 3458 | RSS: Main: 165699584 02:19:25 INFO - PROCESS | 3458 | 02:22:27 INFO - PROCESS | 3458 | Cycle 1(1): loaded http://localhost:33413/tests/dromaeo/cssquery-yui.html (next: http://localhost:33413/tests/dromaeo/cssquery-dojo.html) 02:22:28 INFO - PROCESS | 3458 | RSS: Main: 167698432 02:22:28 INFO - PROCESS | 3458 | 02:22:28 INFO - PROCESS | 3458 | __start_tp_report 02:22:28 INFO - PROCESS | 3458 | _x_x_mozilla_page_load 02:22:28 INFO - PROCESS | 3458 | _x_x_mozilla_page_load_details 02:22:28 INFO - PROCESS | 3458 | |i|pagename|runs| 02:22:28 INFO - PROCESS | 3458 | |0;dojo.html;3104.0998110547944;3115.330204006138;3132.46748052831;3140.7016333448314;3159.0049134522624;5308.761105750241;5308.89382212356;5332.120200166968;5343.192380800733;5397.514223719864;5285.101532739434;5341.06531357013;5373.435789242122;5374.381946076192;5396.163594642837;4869.318295438641;4892.9510704892855;5007.874803129933;5030.421501527317;5077.923831142536;4917.2869933859565;5041.04220198163;5084.389873215219;5097.311862898517;5098.821541246057;4863.246196839478;4919.606431485473;4947.554720075193;4954.182559877634;4961.280614310905;4977.477364876709;4998.12532806761;5005.149124648782;5005.799768009275;5064.696118232918;4963.131451995922;4970.179920313144;4974.527419895104;4989.251612258154;5033.043721692867;5148.4079330876675;5295.4969277918535;5297.708626025567;5307.071262529081;5370.2750128732905;5826.854328641775;5830.271216097988;5835.474807267324;5844.912326315109;5862.091375836752;5736.110902810071;5872.911906321408;5876.706164691748;5879.617824841372;5880.353161152312;5378.838634841;5381.2197231401615;5406.297181366397;5428.321459817523;5429.56563474921;5892.882142357129;5895.469407753323;5900.675462849498;5913.615614985012;5914.0241860093465;5496.862578435571;5663.377028526858;5666.886662266732;5668.773249069991;5670.404607516234;5779.8555036124435;5819.359870414251;5825.155352473867;5828.5337173026055;5882.823515294548;5688.63023903445;5737.684427356536;5786.392428795;5791.247137872134;5797.681127537941;5711.942880571224;5728.369879313273;5741.024025915604;5808.88382232353;5813.447722466359;4366.454193225847;4369.169857727022;4389.517153113155;4391.692581519263;4423.336499525032;3928;3952.01199700075;3971.1065010373013;3983.4821473208876;4016.6987475939422;5418.756155972991;5556.583256255797;5586.35756887955;5628.71856407178;5634.690092044977;5852;5885.117232415172;5895.469407753323;5905.379935106838;5912.17229587858;5437.700926449004;5604.075327570987;5622.212890195376;5629.268195134607;5641.464060914206;4932.4327702314695;4945.851624451272;5001.324821149171;5015.548600625962;5025.447200807981;5945.791897283574;6014.849628759316;6015.819525414245;6021.759129634853;6028.57799953999;5616.438356164351;5768.394318596571;5782.421757824184;5802.332731735735;5805.738741756715;5927.940720592739;5929.407059294036;5930.318013428511;5939.554533409925;5998.760049597967;5703.429657034263;5714.314282286152;5723.284589426322;5735.11105778605;5738;5686;5779;5779.624324418899;5797.942020579909;5835.066389377679;5672.971635141798;5703.315602127771;5743.0811070228565;5777.537796976148;5785.190073389645;5647.576431767716;5685.090385538294;5686.061799802987;5692.6299790513485;5767.279090113736;5479.506844384025;5496.203050557567;5526.613137080527;5593.636413633264;5605.271314729059;5486.643368181056;5518;5554.527865131509;5713.8285851424525;5761.971190144022;5616.775328986795;5629.296337957755;5640.887182256414;5646.209530665792;5669.829905102853 02:22:28 INFO - PROCESS | 3458 | |1;ext.html;594.5154698920379;620.7548018532677;636.274646902531;650.8340373204832;661.6261812076176;38851.41722874156;43339.34990975138;43410.13179736403;43484.347734784;43515.782421087926;42797;43282.567174328244;43554.346684799755;43741.34387984183;43743;8703.869441958375;8842.425242359259;8897.243734282594;8900.37697361185;8908;8840;8923.687670931518;8933;8936.329775266848;8941.374103812735;8934.28525717941;8949.686760963368;8951.776205594848;8984.820303593924;8994.730158095235;8872.512011839346;8890.688825891095;8905.421147625417;8917.866232006525;8930.687425940127;8683.956580217122;8793.560321983876;8820;8834.028256891737;8834.514101724402;33841.6615833841;40768.38847417291;40973.59026409728;41052.38421423681;41314.586854131674;3324.5844269466315;3411.9147021324666;3550.7869527828157;3744.9063773405883;3988.760674359519;30971.22571935697;31325.216869578217;31383.84308078445;31483.37033259322;32803.34393312121;3880.4567360569545;3917.7061720370803;3935.940960885589;3963.8414463421427;4081.1021575253694;261918;263084;263497;264788;264961;35181.29637407237;35766.82116589452;36365.63634363622;36418.63581364205;38330.42504362437;37411;37614.247715045545;37639.059023524635;37744.73531588114;37803.810980944916;15848.52454426369;15968;15975.760363594556;15988.920055399649;16000.519984400487;13130.934345328404;13149.671258218621;13171.93414032943;13174.868251317364;13345.866541334462;8606.397552171413;8662.78343041429;8672.913270867337;8690.695825646071;8728.825423491622;3398.150462384404;3399.490076488497;3399.6061614737837;3412.3004784019217;3443.8794642187404;1141.6632093532428;1163.5927425401042;1203.072980821083;1211.1098342718094;1218.5004148299154;33176;33246.335073298396;33599.664003359656;33641.49537756936;33811.4928276076;1149.6436104807538;1213.769383817072;1260.174585646403;1290.4386591832395;1310.6330227536305;17562.824371756375;17608.55978600545;17709.911450442665;17750.11249437523;17805.910970445064;519672;522282;526582;527336;527360;57604.71197643985;58568.70715646395;58713;58980;59109.40890591125;1304.3608631770364;1309.8231738715342;1315.7368526294588;1317.6771690935782;1353.3706826325608;31163.688363116984;32204;32619;33241.83379083089;33302.666973330925;52460.73769631128;52599;52620;52881.20678189907;52891.206631901325;408333;409608;409839;409848;412013;28109.718902811528;29315.85342073276;29375.853120735115;29380.853095734383;29428.264293392836;47061.294080589505;48177.27871214512;48187.27719084287;48890.26664600105;49820.25269620886;40285.59714402819;41467.37798933079;41700;41782.37326440166;42705;41069.84837186179;41417.79291103525;42180.15639687128;42195;42392.36411453769;41696;42128.57871421369;42216.78891605522;42882.78558607312;43041.569584305005;36466.63533364632;37119.257614848095;37217.81391093027;37320.81339593285;37755.811220944815;28671.56992645154;28882.71117288884;29078.273043173245;29295.85352073311;29325.706742932296 02:22:28 INFO - PROCESS | 3458 | |2;jquery.html;402.4888391742489;405.3838165987699;405.7585736486789;411.7879292164535;416.2798358839208;17931.372401965935;19569.902150489244;19596;20073.397798066046;20588.38234852953;18707.158177881993;18898.967938626065;19126;19632.312869049587;19749.11128999195;5507.917381239275;5684.4315568443035;5699.373068962411;5723.599348045638;5768.048272035109;5525.475079867426;5617.045102332593;5661.46216109469;5673.035583950717;5703.686297253649;5607.719614019303;5660.066089095294;5683.857903552403;5688.687122208277;5695.487406133447;5489.39616642169;5634.464725851038;5666.744996475169;5681.034224181899;5699.515541179005;4982.153033984231;5059.139946209153;5114.05390002847;5127.5385215330425;5181.922271165936;22576.54846903069;23106.537869242522;23194.7680523196;23347.066117355287;23783.762162378327;2481.739417361169;2613.6210249513906;2644.761971422562;2795.496810574096;2863.8854445822144;14498.347574359179;15632.765508517381;15902;16231.188440578042;16536.586585335463;2047.600717860003;2143.2211264650305;2171.2400659769114;2186.365953873391;2191.364504293753;70447.64776176086;82916;89020;90222.5488872558;91761.54119229427;17262.482125536255;17491.650166996587;17672.57441829279;17757.289708411776;17886;32352.67647323544;32381.35237295241;32408.675913241037;32534.83732581322;32703.34593308168;10213.846792298122;10402.843957340647;10764.407957562253;10854.67435976922;10858;9035.322350823715;9176.770580735534;9197.77005574866;9262.305327100494;9341.813163736688;9040.41237319572;9214.493202873773;9311.394759340621;9366.812663746823;9393.483358415217;3463.8614455421502;3582.910427239288;3617.746757726934;3642.417213245868;3722.4788529605876;924.426855349674;996.3125443444001;997.9950100249453;1012.8379459286626;1140.811766058591;19110.044497775056;19396.903015485113;19604.509887252934;19614.70577941332;19775.40673779789;1046.6441409920662;1064.4890452582804;1116.1015382616908;1122.5846436818429;1132.6828488023366;10828.18788590843;11105.38920359388;11162.107031437628;11264;11297;394949;396991;397561;481807;558875;98804.5537950794;100900;101671.49164254131;103465.48267258615;103567.48216259021;1073.27553901118;1074.7098283463577;1097.3415950429678;1100.460774220626;1116.4027245423658;17604.29582816673;17616.207270672596;17627;17728.556786079935;17908.820911791237;40690.59309406868;41082.1783564333;41238.38142427926;41682.374764379165;43168.35247471353;59203;59889;59926.70036649963;59960;60153.398466014776;7709.306162445407;8696.56517174126;8908;8931.508767017876;9107.544622768703;12631.810522842348;13543;13687.452501899812;13734.65663358424;13846.792298115737;11811.468483918072;12091.455884485043;12140.332281724237;12440.813387799371;12716.173448725804;11977.101717371406;12127.878721212675;12170.939145304217;12210.694732631755;12218.45016974256;11777.52889884395;11946.940265298965;12384.690382740504;12492.063095268073;12627;8176.223258790405;8185.590720464072;8220.301274391744;8222.424430289822;8342.624581893951;11955.916288692773;12446.128770985944;12488.43802028929;12602.243865368107;12789.42447589842 02:22:28 INFO - PROCESS | 3458 | |3;mootools.html;1520.7414739494288;1571.1751330551463;1719.4497760716567;1801.5676237702955;1834.7981722010584;7655.808604784883;8101.270885620293;8159.428839981197;8771.166739159778;8771.912280877197;8253.215944485264;8325.29235015023;8335;8377.120402357756;8408.747737567883;2312.629979203328;2331.743508214095;2353.4351755578623;2353.49399879026;2359.55168517981;2267.093162734911;2296.942576435594;2325.500017496238;2338.8012018978407;2344.038944032947;2269.5687819314276;2284.1776960294283;2307.457747429353;2331.0209711920947;2340.602097643396;2267.489814791667;2298.586254474194;2300.7009088818513;2304.43541332373;2314.2247347138727;2274.5337205872756;2294.288770481156;2298.908043678251;2306.6655334976504;2314.8148148148107;8365.581720913991;8420.8315833683;8424.4945303282;8465.068842427328;8523.872141917876;5092.26162206478;5161.741912904377;5167.121589329823;5181.248718935733;5188.688678679291;3319.1038419626566;3343.3814744272145;3368.242145517239;3488.197714525648;3567.8929632110817;1071.287593750155;1109.944502774858;1115.380963565221;1131.8019346614392;1136.1308598921748;11861.52553897843;11870.584529541424;11927.880721192763;11938.761224775542;11951.521939122425;4513.72917624937;4581.083783243298;4602.424696912886;4742.407199100113;4756.738379389098;9456.243500519942;9476;9502.049795020443;9524.571394287274;9547.856782148274;5162.664426812245;5168.819091331786;5198.714070726146;5204.7918083276245;5206.167013277933;4234.06850492891;4729.125111854318;4854.2233242681;4858.58702010333;4876.975615121973;3709.647583479565;3712.7586706863967;3808.923821523554;3826.521684789401;3855.63371479709;1122.141561705296;1141.1612464838338;1149.83327417524;1152.6657269391783;1155.5493357590378;959.5154447004218;1046.9162467002623;1059.750958524746;1073.066432203972;1078.1751959750798;6025.517958563304;6172.722227499773;6178.104174894615;6238.033104868752;6319.494440444753;432.22631489633204;433.8091239854454;438.6819555822004;441.0825482995362;445.1586501512145;4114.7942602870335;4182.456280683492;4228.281192197333;4271.6369108625495;4286.699931004862;10409.115225205942;10510.264281500375;10746.194035447374;10752.838707419394;10820.188485863591;10670.946645266724;10672.146228301717;10700.197485188643;10767.97704218098;10773.299735517323;7862.095858976291;7875.6062196889925;7940.563269020144;8075.919240807634;8108.067572229269;5890.352061273171;5943.554233432596;5989.670568118795;6021.488173505126;6090.756369745161;9760.804783904141;9826.312158149147;9897.703068907944;9949.204063675033;10007.449590272605;9383.577739001625;9804.85292720624;9821.312508124363;10029.097381235724;10108.090271875566;7212.42300615939;7453.403727701662;7627.351675107678;7723;7738.303552680286;8438.873416898628;8483.024452188078;8539.359548033797;8576;8621.180987806149;7619.619019048914;7846.882296765439;7862.52824830512;7893.250141236574;7900.4074694397;7490.925090749241;7629.122650895218;7653.0867283179205;7656.73201437947;7657.961710191414;6714.0600315954825;6749.763758268437;6806.76176333826;6815.148106486689;6840.213375461686;5119.488051195;5200.349956255468;5297.788088476418;5300.496452836975;5334.599905007062;5098.413682426569;5114.105031619526;5154.639175257696;5339.652922560022;5407.567394608501 02:22:28 INFO - PROCESS | 3458 | |4;prototype.html;330.8511169973511;335.7297375612632;336.4179968654228;343.3322188343671;344.76728208459286;5432.402435732071;5551;5555.694436805984;5569.554435645149;5613.270274864267;5483.835484935458;5485.6960076767755;5491.533219676332;5493.890122197554;5521.742172118449;4070.633642972132;4169.812358443877;4288.828446862121;4303.891093364245;4315.525292217853;4235.3646952957;4262.616364527207;4272.209641216369;4280.657547396201;4303.526612072669;4224.176285624305;4224.471941007374;4240.194363071022;4262.680298977589;4278.61492465678;3992.660623846991;4284.8859296582805;4285.185814695214;4286.807093680761;4293.570642935712;3740.7007439405056;3743.2139250757373;3760.157522813829;3761.4545890845675;3762.8682996095004;5328.600354973392;5337.263915259334;5348.251244825728;5354.705491197982;5356.276902618136;4589.334546490773;4821.204501257288;4840.733759643218;4888.266759985995;4904.5340692634145;5651.7739290428335;5653.406392328788;5687.40282270364;5698.772049118031;5740;4037.0109323215706;4083.8979025524304;4100.958990410088;4112.753234805921;4124.092699606082;5766.452187042224;5976.4919981801595;5977.22296101504;5977.671228082454;6025.457708806184;4162.854300099482;4178.603032711888;4190.141021090669;4199.286121359376;4205.789710514462;4167.541570427251;4190;4191.350340697197;4241.384999175102;4246.766427846498;4655.348251244828;4783.808647654055;4785.569298763128;4813.975930120327;4824.517548245148;5678.716064196774;5679.31848178213;5683.346415162227;5700.942990570041;5731.971340143356;1410.5486244401898;1422.3741553716332;1425.759589157419;1427.2435609127178;1427.5289154578963;904.2539904578749;913.8263729891299;966.5264020629841;986.2898712926682;1001.3191030099603;5307.946920530745;5342.572594192456;5402;5458.9454105458435;5478.123500239943;5628.802991895264;5649.435056494318;5690.5163061140265;5716.256886604798;5734.426557344233;5228.660137091077;5361.919571206435;5372.382176049726;5402.810901618424;5456.427075157131;3028.545718142296;3054.6487153977578;3056.419280336729;3060.7704422168426;3071.401076790049;5612.579056570692;5845.181674565564;5947.732352044169;5958.6424814511265;6063.787767428119;5811.244538210006;5831.279772467133;5838.970805145947;5848.753941562389;5868.589198756046;5841.853953651108;5842.620229685057;5896.3219229788265;5901;5909.172715819789;5517.36550296721;5536.031194541019;5612.214289999321;5686.09022556389;5695.544356451557;5549.916751248654;5579.553635709215;5591.888162236651;5615.522680572197;5633.042382795016;5609.4390560943575;5808;5852.736626851717;5878.853028674317;5897.941020589739;3998.9600103998587;4000.6199411055904;4011.1777085697945;4015.6909776878997;4037.333839916381;5657.688827114548;5778.393268706894;5800.390958949419;5842.130518234294;5865.384134665798;5461.9453805461435;5552.750126244248;5688.744006519633;5695.45893140151;5722.427757224411;5504.724763761876;5545.694986775605;5577.860553486195;5607.5513958884;5612.540739407702;5455.509004189642;5476.452354764491;5513.421090785409;5567.164925261243;5626.915596265977;5734.3692193857805;5796.739146738491;5813.94186058134;5821.330546986981;5842.737076831468;5665.150227465913;5683.147527870852;5703.458171473703;5704;5712.942870571407 02:22:28 INFO - PROCESS | 3458 | |5;yui.html;751.9285667861554;773.8452309538092;781.1251398433755;791.924767147121;805.2108933245423;14150.22173780443;14397.64005899853;14792.556223313291;14936;14963.476278330261;14070.788938165935;14071;14133.646658833535;14157;14182.503612373568;796.7012370361115;818.7666515043214;834.1366685480529;845.4589062999685;846.6232526525667;836.0970152235572;842.4987132656059;842.6292431330226;843.9409241353077;846.4032856835946;881.4138597832434;881.8192270584547;882;882.1178821178821;884.5311984648147;872.3893274707698;875.8511053120985;876.4741155306829;877.0440220160025;877.4603618774472;640.2445114764575;640.9903851442232;643.5623775832432;644.3878315600199;645.5448908519529;14409.423623055065;14516.274186290642;14525.78211326831;14555.490557830424;14586.270686465741;13740.793888091686;13834.169949803045;13863.098898571561;13877.583672489842;13976.440942362293;11373.374464404455;11464.923868455842;11567.42162891852;11658.183927125105;11794.233374830608;3856.749311294757;3873.593272706353;3911;3926.371780515104;4041.4544036555276;57028.42971570314;57101.42898571002;57432.71283643597;57492.425075749125;57903.71048144774;10808.945955270174;10825;10862.34004020138;10972.506237219344;11173.329600224013;19072.71390929137;19072.90463547701;19090.904545477184;19121.61756764857;19164.61670766577;8153.388495862834;8359.289460395934;8364.247217750431;8424.199701028392;8649.351298652626;4790.640701947298;4888.388951381077;4888.584470320063;5032.874178145576;5094.5160209780015;3318.6515415881468;3420.4698271767916;3421.196018935548;3423.7432192585156;3430.7255419566377;598.1207624791549;608.8934436473688;611.8745657140275;615.1756646094166;618.7153909201818;735.2059775442509;743.3495691270139;759.7189040055215;784.9489783164076;799.8640231160716;9590.328676992543;9593.712188634352;9677.838659360781;9696.75758106053;9921.851172232422;763.5495057915856;780.7813812132612;791.1258059843905;794.1899262751961;796.8645330293864;4620.006698559759;4627.8843028923875;4747.311639812277;4752.811162310816;4899.118158731462;62075.37924620696;64805;65682;65783.34216657867;65914;57495.26280791735;58612.7069364659;59279.40720592825;59387.70306148442;59834;53182;53462.19806702903;53463.46536534585;53499.46500534945;53883.19175212375;9313.70122090084;9325.86011209846;9391.107844754737;9437.764055898382;9454.290928180277;32587;33007.83496082504;33833;33882.66117338795;34164.31671366509;44406.55593444024;46908.29637555371;47421.52578474309;47446.76276618595;47942.28086578774;11027.22809403334;11248.212625116163;11342.829857551978;11449.828252576051;11557;12718.364081795688;13079.738405232032;13168.736625267633;13196.472141114247;13914.582562523141;11392.373419462008;12108.335116361215;12174.33041182708;12174.634760957186;12189.207701499374;12628.368581570701;12923.22460652364;13255;13276;13322.134061285986;12014.459349329476;12325.383730813603;12515;12581.93709031449;12687.492500299884;10019.799604008025;10091.293609447563;10402.115820155372;10767.515461804081;10830.350178989285;9705.369151005161;10143.847842282225;10301.74245643865;10374.377537347784;10386.636467723594 02:22:28 INFO - PROCESS | 3458 | __end_tp_report 02:22:28 INFO - PROCESS | 3458 | __start_cc_report 02:22:28 INFO - PROCESS | 3458 | _x_x_mozilla_cycle_collect,355 02:22:28 INFO - PROCESS | 3458 | __end_cc_report 02:22:28 INFO - PROCESS | 3458 | __startTimestamp1462526548072__endTimestamp 02:22:28 INFO - PROCESS | 3458 | 02:22:28 INFO - PROCESS | 3458 | ------- Summary: start ------- 02:22:28 INFO - PROCESS | 3458 | Number of tests: 6 02:22:28 INFO - PROCESS | 3458 | 02:22:28 INFO - PROCESS | 3458 | [#0] dojo.html Cycles:165 Average:5389.16 Median:5628.72 stddev:608.36 (10.8%) stddev-sans-first:583.21 02:22:28 INFO - PROCESS | 3458 | Values: 3104.1 3115.3 3132.5 3140.7 3159.0 5308.8 5308.9 5332.1 5343.2 5397.5 5285.1 5341.1 5373.4 5374.4 5396.2 4869.3 4893.0 5007.9 5030.4 5077.9 4917.3 5041.0 5084.4 5097.3 5098.8 4863.2 4919.6 4947.6 4954.2 4961.3 4977.5 4998.1 5005.1 5005.8 5064.7 4963.1 4970.2 4974.5 4989.3 5033.0 5148.4 5295.5 5297.7 5307.1 5370.3 5826.9 5830.3 5835.5 5844.9 5862.1 5736.1 5872.9 5876.7 5879.6 5880.4 5378.8 5381.2 5406.3 5428.3 5429.6 5892.9 5895.5 5900.7 5913.6 5914.0 5496.9 5663.4 5666.9 5668.8 5670.4 5779.9 5819.4 5825.2 5828.5 5882.8 5688.6 5737.7 5786.4 5791.2 5797.7 5711.9 5728.4 5741.0 5808.9 5813.4 4366.5 4369.2 4389.5 4391.7 4423.3 3928.0 3952.0 3971.1 3983.5 4016.7 5418.8 5556.6 5586.4 5628.7 5634.7 5852.0 5885.1 5895.5 5905.4 5912.2 5437.7 5604.1 5622.2 5629.3 5641.5 4932.4 4945.9 5001.3 5015.5 5025.4 5945.8 6014.8 6015.8 6021.8 6028.6 5616.4 5768.4 5782.4 5802.3 5805.7 5927.9 5929.4 5930.3 5939.6 5998.8 5703.4 5714.3 5723.3 5735.1 5738.0 5686.0 5779.0 5779.6 5797.9 5835.1 5673.0 5703.3 5743.1 5777.5 5785.2 5647.6 5685.1 5686.1 5692.6 5767.3 5479.5 5496.2 5526.6 5593.6 5605.3 5486.6 5518.0 5554.5 5713.8 5762.0 5616.8 5629.3 5640.9 5646.2 5669.8 02:22:28 INFO - PROCESS | 3458 | 02:22:28 INFO - PROCESS | 3458 | [#1] ext.html Cycles:180 Average:55322.06 Median:22137.18 stddev:109850.19 (496.2%) stddev-sans-first:110081.50 02:22:28 INFO - PROCESS | 3458 | Values: 594.5 620.8 636.3 650.8 661.6 38851.4 43339.3 43410.1 43484.3 43515.8 42797.0 43282.6 43554.3 43741.3 43743.0 8703.9 8842.4 8897.2 8900.4 8908.0 8840.0 8923.7 8933.0 8936.3 8941.4 8934.3 8949.7 8951.8 8984.8 8994.7 8872.5 8890.7 8905.4 8917.9 8930.7 8684.0 8793.6 8820.0 8834.0 8834.5 33841.7 40768.4 40973.6 41052.4 41314.6 3324.6 3411.9 3550.8 3744.9 3988.8 30971.2 31325.2 31383.8 31483.4 32803.3 3880.5 3917.7 3935.9 3963.8 4081.1 261918.0 263084.0 263497.0 264788.0 264961.0 35181.3 35766.8 36365.6 36418.6 38330.4 37411.0 37614.2 37639.1 37744.7 37803.8 15848.5 15968.0 15975.8 15988.9 16000.5 13130.9 13149.7 13171.9 13174.9 13345.9 8606.4 8662.8 8672.9 8690.7 8728.8 3398.2 3399.5 3399.6 3412.3 3443.9 1141.7 1163.6 1203.1 1211.1 1218.5 33176.0 33246.3 33599.7 33641.5 33811.5 1149.6 1213.8 1260.2 1290.4 1310.6 17562.8 17608.6 17709.9 17750.1 17805.9 519672.0 522282.0 526582.0 527336.0 527360.0 57604.7 58568.7 58713.0 58980.0 59109.4 1304.4 1309.8 1315.7 1317.7 1353.4 31163.7 32204.0 32619.0 33241.8 33302.7 52460.7 52599.0 52620.0 52881.2 52891.2 408333.0 409608.0 409839.0 409848.0 412013.0 28109.7 29315.9 29375.9 29380.9 29428.3 47061.3 48177.3 48187.3 48890.3 49820.3 40285.6 41467.4 41700.0 41782.4 42705.0 41069.8 41417.8 42180.2 42195.0 42392.4 41696.0 42128.6 42216.8 42882.8 43041.6 36466.6 37119.3 37217.8 37320.8 37755.8 28671.6 28882.7 29078.3 29295.9 29325.7 02:22:28 INFO - PROCESS | 3458 | 02:22:28 INFO - PROCESS | 3458 | [#2] jquery.html Cycles:180 Average:29401.59 Median:13132.75 stddev:74768.74 (569.3%) stddev-sans-first:74946.79 02:22:28 INFO - PROCESS | 3458 | Values: 402.5 405.4 405.8 411.8 416.3 17931.4 19569.9 19596.0 20073.4 20588.4 18707.2 18899.0 19126.0 19632.3 19749.1 5507.9 5684.4 5699.4 5723.6 5768.0 5525.5 5617.0 5661.5 5673.0 5703.7 5607.7 5660.1 5683.9 5688.7 5695.5 5489.4 5634.5 5666.7 5681.0 5699.5 4982.2 5059.1 5114.1 5127.5 5181.9 22576.5 23106.5 23194.8 23347.1 23783.8 2481.7 2613.6 2644.8 2795.5 2863.9 14498.3 15632.8 15902.0 16231.2 16536.6 2047.6 2143.2 2171.2 2186.4 2191.4 70447.6 82916.0 89020.0 90222.5 91761.5 17262.5 17491.7 17672.6 17757.3 17886.0 32352.7 32381.4 32408.7 32534.8 32703.3 10213.8 10402.8 10764.4 10854.7 10858.0 9035.3 9176.8 9197.8 9262.3 9341.8 9040.4 9214.5 9311.4 9366.8 9393.5 3463.9 3582.9 3617.7 3642.4 3722.5 924.4 996.3 998.0 1012.8 1140.8 19110.0 19396.9 19604.5 19614.7 19775.4 1046.6 1064.5 1116.1 1122.6 1132.7 10828.2 11105.4 11162.1 11264.0 11297.0 394949.0 396991.0 397561.0 481807.0 558875.0 98804.6 100900.0 101671.5 103465.5 103567.5 1073.3 1074.7 1097.3 1100.5 1116.4 17604.3 17616.2 17627.0 17728.6 17908.8 40690.6 41082.2 41238.4 41682.4 43168.4 59203.0 59889.0 59926.7 59960.0 60153.4 7709.3 8696.6 8908.0 8931.5 9107.5 12631.8 13543.0 13687.5 13734.7 13846.8 11811.5 12091.5 12140.3 12440.8 12716.2 11977.1 12127.9 12170.9 12210.7 12218.5 11777.5 11946.9 12384.7 12492.1 12627.0 8176.2 8185.6 8220.3 8222.4 8342.6 11955.9 12446.1 12488.4 12602.2 12789.4 02:22:28 INFO - PROCESS | 3458 | 02:22:28 INFO - PROCESS | 3458 | [#3] mootools.html Cycles:180 Average:5683.19 Median:4867.78 stddev:3188.99 (65.5%) stddev-sans-first:3182.60 02:22:28 INFO - PROCESS | 3458 | Values: 1520.7 1571.2 1719.4 1801.6 1834.8 7655.8 8101.3 8159.4 8771.2 8771.9 8253.2 8325.3 8335.0 8377.1 8408.7 2312.6 2331.7 2353.4 2353.5 2359.6 2267.1 2296.9 2325.5 2338.8 2344.0 2269.6 2284.2 2307.5 2331.0 2340.6 2267.5 2298.6 2300.7 2304.4 2314.2 2274.5 2294.3 2298.9 2306.7 2314.8 8365.6 8420.8 8424.5 8465.1 8523.9 5092.3 5161.7 5167.1 5181.2 5188.7 3319.1 3343.4 3368.2 3488.2 3567.9 1071.3 1109.9 1115.4 1131.8 1136.1 11861.5 11870.6 11927.9 11938.8 11951.5 4513.7 4581.1 4602.4 4742.4 4756.7 9456.2 9476.0 9502.0 9524.6 9547.9 5162.7 5168.8 5198.7 5204.8 5206.2 4234.1 4729.1 4854.2 4858.6 4877.0 3709.6 3712.8 3808.9 3826.5 3855.6 1122.1 1141.2 1149.8 1152.7 1155.5 959.5 1046.9 1059.8 1073.1 1078.2 6025.5 6172.7 6178.1 6238.0 6319.5 432.2 433.8 438.7 441.1 445.2 4114.8 4182.5 4228.3 4271.6 4286.7 10409.1 10510.3 10746.2 10752.8 10820.2 10670.9 10672.1 10700.2 10768.0 10773.3 7862.1 7875.6 7940.6 8075.9 8108.1 5890.4 5943.6 5989.7 6021.5 6090.8 9760.8 9826.3 9897.7 9949.2 10007.4 9383.6 9804.9 9821.3 10029.1 10108.1 7212.4 7453.4 7627.4 7723.0 7738.3 8438.9 8483.0 8539.4 8576.0 8621.2 7619.6 7846.9 7862.5 7893.3 7900.4 7490.9 7629.1 7653.1 7656.7 7658.0 6714.1 6749.8 6806.8 6815.1 6840.2 5119.5 5200.3 5297.8 5300.5 5334.6 5098.4 5114.1 5154.6 5339.7 5407.6 02:22:28 INFO - PROCESS | 3458 | 02:22:28 INFO - PROCESS | 3458 | [#4] prototype.html Cycles:180 Average:4759.96 Median:5484.77 stddev:1392.37 (25.4%) stddev-sans-first:1356.00 02:22:28 INFO - PROCESS | 3458 | Values: 330.9 335.7 336.4 343.3 344.8 5432.4 5551.0 5555.7 5569.6 5613.3 5483.8 5485.7 5491.5 5493.9 5521.7 4070.6 4169.8 4288.8 4303.9 4315.5 4235.4 4262.6 4272.2 4280.7 4303.5 4224.2 4224.5 4240.2 4262.7 4278.6 3992.7 4284.9 4285.2 4286.8 4293.6 3740.7 3743.2 3760.2 3761.5 3762.9 5328.6 5337.3 5348.3 5354.7 5356.3 4589.3 4821.2 4840.7 4888.3 4904.5 5651.8 5653.4 5687.4 5698.8 5740.0 4037.0 4083.9 4101.0 4112.8 4124.1 5766.5 5976.5 5977.2 5977.7 6025.5 4162.9 4178.6 4190.1 4199.3 4205.8 4167.5 4190.0 4191.4 4241.4 4246.8 4655.3 4783.8 4785.6 4814.0 4824.5 5678.7 5679.3 5683.3 5700.9 5732.0 1410.5 1422.4 1425.8 1427.2 1427.5 904.3 913.8 966.5 986.3 1001.3 5307.9 5342.6 5402.0 5458.9 5478.1 5628.8 5649.4 5690.5 5716.3 5734.4 5228.7 5361.9 5372.4 5402.8 5456.4 3028.5 3054.6 3056.4 3060.8 3071.4 5612.6 5845.2 5947.7 5958.6 6063.8 5811.2 5831.3 5839.0 5848.8 5868.6 5841.9 5842.6 5896.3 5901.0 5909.2 5517.4 5536.0 5612.2 5686.1 5695.5 5549.9 5579.6 5591.9 5615.5 5633.0 5609.4 5808.0 5852.7 5878.9 5897.9 3999.0 4000.6 4011.2 4015.7 4037.3 5657.7 5778.4 5800.4 5842.1 5865.4 5461.9 5552.8 5688.7 5695.5 5722.4 5504.7 5545.7 5577.9 5607.6 5612.5 5455.5 5476.5 5513.4 5567.2 5626.9 5734.4 5796.7 5813.9 5821.3 5842.7 5665.2 5683.1 5703.5 5704.0 5712.9 02:22:28 INFO - PROCESS | 3458 | 02:22:28 INFO - PROCESS | 3458 | [#5] yui.html Cycles:180 Average:15218.67 Median:4750.06 stddev:17975.36 (378.4%) stddev-sans-first:17992.95 02:22:28 INFO - PROCESS | 3458 | Values: 751.9 773.8 781.1 791.9 805.2 14150.2 14397.6 14792.6 14936.0 14963.5 14070.8 14071.0 14133.6 14157.0 14182.5 796.7 818.8 834.1 845.5 846.6 836.1 842.5 842.6 843.9 846.4 881.4 881.8 882.0 882.1 884.5 872.4 875.9 876.5 877.0 877.5 640.2 641.0 643.6 644.4 645.5 14409.4 14516.3 14525.8 14555.5 14586.3 13740.8 13834.2 13863.1 13877.6 13976.4 11373.4 11464.9 11567.4 11658.2 11794.2 3856.7 3873.6 3911.0 3926.4 4041.5 57028.4 57101.4 57432.7 57492.4 57903.7 10808.9 10825.0 10862.3 10972.5 11173.3 19072.7 19072.9 19090.9 19121.6 19164.6 8153.4 8359.3 8364.2 8424.2 8649.4 4790.6 4888.4 4888.6 5032.9 5094.5 3318.7 3420.5 3421.2 3423.7 3430.7 598.1 608.9 611.9 615.2 618.7 735.2 743.3 759.7 784.9 799.9 9590.3 9593.7 9677.8 9696.8 9921.9 763.5 780.8 791.1 794.2 796.9 4620.0 4627.9 4747.3 4752.8 4899.1 62075.4 64805.0 65682.0 65783.3 65914.0 57495.3 58612.7 59279.4 59387.7 59834.0 53182.0 53462.2 53463.5 53499.5 53883.2 9313.7 9325.9 9391.1 9437.8 9454.3 32587.0 33007.8 33833.0 33882.7 34164.3 44406.6 46908.3 47421.5 47446.8 47942.3 11027.2 11248.2 11342.8 11449.8 11557.0 12718.4 13079.7 13168.7 13196.5 13914.6 11392.4 12108.3 12174.3 12174.6 12189.2 12628.4 12923.2 13255.0 13276.0 13322.1 12014.5 12325.4 12515.0 12581.9 12687.5 10019.8 10091.3 10402.1 10767.5 10830.4 9705.4 10143.8 10301.7 10374.4 10386.6 02:22:28 INFO - PROCESS | 3458 | -------- Summary: end -------- 02:22:28 INFO - PROCESS | 3458 | 02:22:28 INFO - TEST-INFO | 3458: exit 0 02:22:28 INFO - TEST-OK | dromaeo_css | took 1111900ms 02:22:28 INFO - TEST-START | kraken 02:22:28 INFO - operating with platform_type : linux_ 02:22:28 INFO - Initialising browser for kraken test... 02:22:28 INFO - TEST-INFO | started process 3691 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzl9iKx/profile http://localhost:33413/getInfo.html) 02:22:32 INFO - PROCESS | 3691 | 02:22:32 INFO - PROCESS | 3691 | (process:3757): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:22:33 INFO - PROCESS | 3691 | __metrics Screen width/height:1600/1200 02:22:33 INFO - PROCESS | 3691 | colorDepth:24 02:22:33 INFO - PROCESS | 3691 | Browser inner width/height: 1024/697 02:22:33 INFO - PROCESS | 3691 | __metrics 02:22:33 ERROR - PROCESS | 3691 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 02:22:34 INFO - TEST-INFO | 3691: exit 0 02:22:34 INFO - Browser initialized. 02:22:34 INFO - Running cycle 1/1 for kraken test... 02:22:34 INFO - TEST-INFO | started process 3808 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzl9iKx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:22:36 INFO - PROCESS | 3808 | 02:22:36 INFO - PROCESS | 3808 | (process:3868): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:22:46 INFO - PROCESS | 3808 | RSS: Main: 163401728 02:22:46 INFO - PROCESS | 3808 | 02:22:49 INFO - PROCESS | 3808 | Cycle 1(1): loaded http://localhost:33413/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33413/tests/kraken/driver.html?testName=audio-beat-detection) 02:22:49 INFO - PROCESS | 3808 | RSS: Main: 167895040 02:22:49 INFO - PROCESS | 3808 | 02:22:52 INFO - PROCESS | 3808 | Cycle 1(1): loaded http://localhost:33413/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33413/tests/kraken/driver.html?testName=audio-dft) 02:22:53 INFO - PROCESS | 3808 | RSS: Main: 167698432 02:22:53 INFO - PROCESS | 3808 | 02:22:56 INFO - PROCESS | 3808 | Cycle 1(1): loaded http://localhost:33413/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33413/tests/kraken/driver.html?testName=audio-fft) 02:22:56 INFO - PROCESS | 3808 | RSS: Main: 162791424 02:22:56 INFO - PROCESS | 3808 | 02:22:59 INFO - PROCESS | 3808 | Cycle 1(1): loaded http://localhost:33413/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33413/tests/kraken/driver.html?testName=audio-oscillator) 02:22:59 INFO - PROCESS | 3808 | RSS: Main: 163078144 02:22:59 INFO - PROCESS | 3808 | 02:23:01 INFO - PROCESS | 3808 | Cycle 1(1): loaded http://localhost:33413/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33413/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:23:02 INFO - PROCESS | 3808 | RSS: Main: 163311616 02:23:02 INFO - PROCESS | 3808 | 02:23:05 INFO - PROCESS | 3808 | Cycle 1(1): loaded http://localhost:33413/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33413/tests/kraken/driver.html?testName=imaging-darkroom) 02:23:06 INFO - PROCESS | 3808 | RSS: Main: 163524608 02:23:06 INFO - PROCESS | 3808 | 02:23:09 INFO - PROCESS | 3808 | Cycle 1(1): loaded http://localhost:33413/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33413/tests/kraken/driver.html?testName=imaging-desaturate) 02:23:10 INFO - PROCESS | 3808 | RSS: Main: 163627008 02:23:10 INFO - PROCESS | 3808 | 02:23:13 INFO - PROCESS | 3808 | Cycle 1(1): loaded http://localhost:33413/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33413/tests/kraken/driver.html?testName=json-parse-financial) 02:23:13 INFO - PROCESS | 3808 | RSS: Main: 164286464 02:23:13 INFO - PROCESS | 3808 | 02:23:15 INFO - PROCESS | 3808 | Cycle 1(1): loaded http://localhost:33413/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33413/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:23:15 INFO - PROCESS | 3808 | RSS: Main: 164044800 02:23:15 INFO - PROCESS | 3808 | 02:23:17 INFO - PROCESS | 3808 | Cycle 1(1): loaded http://localhost:33413/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33413/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:23:18 INFO - PROCESS | 3808 | RSS: Main: 164229120 02:23:18 INFO - PROCESS | 3808 | 02:23:20 INFO - PROCESS | 3808 | Cycle 1(1): loaded http://localhost:33413/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33413/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:23:21 INFO - PROCESS | 3808 | RSS: Main: 164098048 02:23:21 INFO - PROCESS | 3808 | 02:23:23 INFO - PROCESS | 3808 | Cycle 1(1): loaded http://localhost:33413/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33413/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:23:24 INFO - PROCESS | 3808 | RSS: Main: 164265984 02:23:24 INFO - PROCESS | 3808 | 02:23:27 INFO - PROCESS | 3808 | Cycle 1(1): loaded http://localhost:33413/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33413/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:23:27 INFO - PROCESS | 3808 | RSS: Main: 164012032 02:23:27 INFO - PROCESS | 3808 | 02:23:29 INFO - PROCESS | 3808 | Cycle 1(1): loaded http://localhost:33413/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33413/tests/kraken/driver.html?testName=ai-astar) 02:23:29 INFO - PROCESS | 3808 | RSS: Main: 166162432 02:23:29 INFO - PROCESS | 3808 | 02:23:29 INFO - PROCESS | 3808 | __start_tp_report 02:23:29 INFO - PROCESS | 3808 | _x_x_mozilla_page_load 02:23:29 INFO - PROCESS | 3808 | _x_x_mozilla_page_load_details 02:23:29 INFO - PROCESS | 3808 | |i|pagename|runs| 02:23:29 INFO - PROCESS | 3808 | |0;ai-astar;110;113;105;112;112;114;106;110;114;114 02:23:29 INFO - PROCESS | 3808 | |1;audio-beat-detection;153;127;152;181;125;150;150;133;194;134 02:23:29 INFO - PROCESS | 3808 | |2;audio-dft;163;171;166;162;164;166;171;162;163;161 02:23:29 INFO - PROCESS | 3808 | |3;audio-fft;75;76;74;153;78;76;75;76;163;76 02:23:29 INFO - PROCESS | 3808 | |4;audio-oscillator;92;91;146;92;92;94;146;92;93;159 02:23:29 INFO - PROCESS | 3808 | |5;imaging-gaussian-blur;117;118;118;118;117;117;118;117;118;117 02:23:29 INFO - PROCESS | 3808 | |6;imaging-darkroom;145;146;147;147;147;147;149;147;148;148 02:23:29 INFO - PROCESS | 3808 | |7;imaging-desaturate;97;97;95;96;95;95;96;95;95;96 02:23:29 INFO - PROCESS | 3808 | |8;json-parse-financial;60;60;56;56;58;58;57;76;57;59 02:23:29 INFO - PROCESS | 3808 | |9;json-stringify-tinderbox;58;59;59;59;58;58;58;59;58;58 02:23:29 INFO - PROCESS | 3808 | |10;stanford-crypto-aes;78;80;79;79;83;90;78;78;79;79 02:23:29 INFO - PROCESS | 3808 | |11;stanford-crypto-ccm;128;127;125;125;131;131;124;134;161;124 02:23:29 INFO - PROCESS | 3808 | |12;stanford-crypto-pbkdf2;172;172;165;176;171;165;167;166;165;165 02:23:29 INFO - PROCESS | 3808 | |13;stanford-crypto-sha256-iterative;66;70;65;64;64;67;63;64;65;63 02:23:29 INFO - PROCESS | 3808 | __end_tp_report 02:23:29 INFO - PROCESS | 3808 | __start_cc_report 02:23:29 INFO - PROCESS | 3808 | _x_x_mozilla_cycle_collect,848 02:23:29 INFO - PROCESS | 3808 | __end_cc_report 02:23:29 INFO - PROCESS | 3808 | __startTimestamp1462526609894__endTimestamp 02:23:29 INFO - PROCESS | 3808 | 02:23:29 INFO - PROCESS | 3808 | ------- Summary: start ------- 02:23:29 INFO - PROCESS | 3808 | Number of tests: 14 02:23:29 INFO - PROCESS | 3808 | 02:23:29 INFO - PROCESS | 3808 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.50 stddev:3.27 (2.9%) stddev-sans-first:3.44 02:23:29 INFO - PROCESS | 3808 | Values: 110.0 113.0 105.0 112.0 112.0 114.0 106.0 110.0 114.0 114.0 02:23:29 INFO - PROCESS | 3808 | 02:23:29 INFO - PROCESS | 3808 | [#1] audio-beat-detection Cycles:10 Average:149.90 Median:151.00 stddev:22.63 (15.0%) stddev-sans-first:23.97 02:23:29 INFO - PROCESS | 3808 | Values: 153.0 127.0 152.0 181.0 125.0 150.0 150.0 133.0 194.0 134.0 02:23:29 INFO - PROCESS | 3808 | 02:23:29 INFO - PROCESS | 3808 | [#2] audio-dft Cycles:10 Average:164.90 Median:165.00 stddev:3.60 (2.2%) stddev-sans-first:3.76 02:23:29 INFO - PROCESS | 3808 | Values: 163.0 171.0 166.0 162.0 164.0 166.0 171.0 162.0 163.0 161.0 02:23:29 INFO - PROCESS | 3808 | 02:23:29 INFO - PROCESS | 3808 | [#3] audio-fft Cycles:10 Average:92.20 Median:76.00 stddev:34.77 (45.8%) stddev-sans-first:36.32 02:23:29 INFO - PROCESS | 3808 | Values: 75.0 76.0 74.0 153.0 78.0 76.0 75.0 76.0 163.0 76.0 02:23:29 INFO - PROCESS | 3808 | 02:23:29 INFO - PROCESS | 3808 | [#4] audio-oscillator Cycles:10 Average:109.70 Median:92.00 stddev:28.27 (30.7%) stddev-sans-first:29.25 02:23:29 INFO - PROCESS | 3808 | Values: 92.0 91.0 146.0 92.0 92.0 94.0 146.0 92.0 93.0 159.0 02:23:29 INFO - PROCESS | 3808 | 02:23:29 INFO - PROCESS | 3808 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 02:23:29 INFO - PROCESS | 3808 | Values: 117.0 118.0 118.0 118.0 117.0 117.0 118.0 117.0 118.0 117.0 02:23:29 INFO - PROCESS | 3808 | 02:23:29 INFO - PROCESS | 3808 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:1.10 (0.7%) stddev-sans-first:0.87 02:23:29 INFO - PROCESS | 3808 | Values: 145.0 146.0 147.0 147.0 147.0 147.0 149.0 147.0 148.0 148.0 02:23:29 INFO - PROCESS | 3808 | 02:23:29 INFO - PROCESS | 3808 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.73 02:23:29 INFO - PROCESS | 3808 | Values: 97.0 97.0 95.0 96.0 95.0 95.0 96.0 95.0 95.0 96.0 02:23:29 INFO - PROCESS | 3808 | 02:23:29 INFO - PROCESS | 3808 | [#8] json-parse-financial Cycles:10 Average:59.70 Median:58.50 stddev:5.91 (10.1%) stddev-sans-first:6.26 02:23:29 INFO - PROCESS | 3808 | Values: 60.0 60.0 56.0 56.0 58.0 58.0 57.0 76.0 57.0 59.0 02:23:29 INFO - PROCESS | 3808 | 02:23:29 INFO - PROCESS | 3808 | [#9] json-stringify-tinderbox Cycles:10 Average:58.40 Median:58.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 02:23:29 INFO - PROCESS | 3808 | Values: 58.0 59.0 59.0 59.0 58.0 58.0 58.0 59.0 58.0 58.0 02:23:29 INFO - PROCESS | 3808 | 02:23:29 INFO - PROCESS | 3808 | [#10] stanford-crypto-aes Cycles:10 Average:80.30 Median:79.00 stddev:3.71 (4.7%) stddev-sans-first:3.84 02:23:29 INFO - PROCESS | 3808 | Values: 78.0 80.0 79.0 79.0 83.0 90.0 78.0 78.0 79.0 79.0 02:23:29 INFO - PROCESS | 3808 | 02:23:29 INFO - PROCESS | 3808 | [#11] stanford-crypto-ccm Cycles:10 Average:131.00 Median:129.50 stddev:11.08 (8.6%) stddev-sans-first:11.69 02:23:29 INFO - PROCESS | 3808 | Values: 128.0 127.0 125.0 125.0 131.0 131.0 124.0 134.0 161.0 124.0 02:23:29 INFO - PROCESS | 3808 | 02:23:29 INFO - PROCESS | 3808 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.40 Median:169.00 stddev:4.01 (2.4%) stddev-sans-first:4.03 02:23:29 INFO - PROCESS | 3808 | Values: 172.0 172.0 165.0 176.0 171.0 165.0 167.0 166.0 165.0 165.0 02:23:29 INFO - PROCESS | 3808 | 02:23:29 INFO - PROCESS | 3808 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.10 Median:65.00 stddev:2.13 (3.3%) stddev-sans-first:2.24 02:23:29 INFO - PROCESS | 3808 | Values: 66.0 70.0 65.0 64.0 64.0 67.0 63.0 64.0 65.0 63.0 02:23:29 INFO - PROCESS | 3808 | -------- Summary: end -------- 02:23:29 INFO - PROCESS | 3808 | 02:23:30 INFO - TEST-INFO | 3808: exit 0 02:23:30 INFO - TEST-OK | kraken | took 62058ms 02:23:30 INFO - SUITE-END | took 1173s 02:23:31 INFO - Completed test suite (00:19:34) 02:23:31 INFO - javascript benchmark 02:23:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3104.0998110547944, 3115.330204006138, 3132.46748052831, 3140.7016333448314, 3159.0049134522624, 5308.761105750241, 5308.89382212356, 5332.120200166968, 5343.192380800733, 5397.514223719864, 5285.101532739434, 5341.06531357013, 5373.435789242122, 5374.381946076192, 5396.163594642837, 4869.318295438641, 4892.9510704892855, 5007.874803129933, 5030.421501527317, 5077.923831142536, 4917.2869933859565, 5041.04220198163, 5084.389873215219, 5097.311862898517, 5098.821541246057, 4863.246196839478, 4919.606431485473, 4947.554720075193, 4954.182559877634, 4961.280614310905, 4977.477364876709, 4998.12532806761, 5005.149124648782, 5005.799768009275, 5064.696118232918, 4963.131451995922, 4970.179920313144, 4974.527419895104, 4989.251612258154, 5033.043721692867, 5148.4079330876675, 5295.4969277918535, 5297.708626025567, 5307.071262529081, 5370.2750128732905, 5826.854328641775, 5830.271216097988, 5835.474807267324, 5844.912326315109, 5862.091375836752, 5736.110902810071, 5872.911906321408, 5876.706164691748, 5879.617824841372, 5880.353161152312, 5378.838634841, 5381.2197231401615, 5406.297181366397, 5428.321459817523, 5429.56563474921, 5892.882142357129, 5895.469407753323, 5900.675462849498, 5913.615614985012, 5914.0241860093465, 5496.862578435571, 5663.377028526858, 5666.886662266732, 5668.773249069991, 5670.404607516234, 5779.8555036124435, 5819.359870414251, 5825.155352473867, 5828.5337173026055, 5882.823515294548, 5688.63023903445, 5737.684427356536, 5786.392428795, 5791.247137872134, 5797.681127537941, 5711.942880571224, 5728.369879313273, 5741.024025915604, 5808.88382232353, 5813.447722466359, 4366.454193225847, 4369.169857727022, 4389.517153113155, 4391.692581519263, 4423.336499525032, 3928.0, 3952.01199700075, 3971.1065010373013, 3983.4821473208876, 4016.6987475939422, 5418.756155972991, 5556.583256255797, 5586.35756887955, 5628.71856407178, 5634.690092044977, 5852.0, 5885.117232415172, 5895.469407753323, 5905.379935106838, 5912.17229587858, 5437.700926449004, 5604.075327570987, 5622.212890195376, 5629.268195134607, 5641.464060914206, 4932.4327702314695, 4945.851624451272, 5001.324821149171, 5015.548600625962, 5025.447200807981, 5945.791897283574, 6014.849628759316, 6015.819525414245, 6021.759129634853, 6028.57799953999, 5616.438356164351, 5768.394318596571, 5782.421757824184, 5802.332731735735, 5805.738741756715, 5927.940720592739, 5929.407059294036, 5930.318013428511, 5939.554533409925, 5998.760049597967, 5703.429657034263, 5714.314282286152, 5723.284589426322, 5735.11105778605, 5738.0, 5686.0, 5779.0, 5779.624324418899, 5797.942020579909, 5835.066389377679, 5672.971635141798, 5703.315602127771, 5743.0811070228565, 5777.537796976148, 5785.190073389645, 5647.576431767716, 5685.090385538294, 5686.061799802987, 5692.6299790513485, 5767.279090113736, 5479.506844384025, 5496.203050557567, 5526.613137080527, 5593.636413633264, 5605.271314729059, 5486.643368181056, 5518.0, 5554.527865131509, 5713.8285851424525, 5761.971190144022, 5616.775328986795, 5629.296337957755, 5640.887182256414, 5646.209530665792, 5669.829905102853], "value": 5348.127453115914, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [594.5154698920379, 620.7548018532677, 636.274646902531, 650.8340373204832, 661.6261812076176, 38851.41722874156, 43339.34990975138, 43410.13179736403, 43484.347734784, 43515.782421087926, 42797.0, 43282.567174328244, 43554.346684799755, 43741.34387984183, 43743.0, 8703.869441958375, 8842.425242359259, 8897.243734282594, 8900.37697361185, 8908.0, 8840.0, 8923.687670931518, 8933.0, 8936.329775266848, 8941.374103812735, 8934.28525717941, 8949.686760963368, 8951.776205594848, 8984.820303593924, 8994.730158095235, 8872.512011839346, 8890.688825891095, 8905.421147625417, 8917.866232006525, 8930.687425940127, 8683.956580217122, 8793.560321983876, 8820.0, 8834.028256891737, 8834.514101724402, 33841.6615833841, 40768.38847417291, 40973.59026409728, 41052.38421423681, 41314.586854131674, 3324.5844269466315, 3411.9147021324666, 3550.7869527828157, 3744.9063773405883, 3988.760674359519, 30971.22571935697, 31325.216869578217, 31383.84308078445, 31483.37033259322, 32803.34393312121, 3880.4567360569545, 3917.7061720370803, 3935.940960885589, 3963.8414463421427, 4081.1021575253694, 261918.0, 263084.0, 263497.0, 264788.0, 264961.0, 35181.29637407237, 35766.82116589452, 36365.63634363622, 36418.63581364205, 38330.42504362437, 37411.0, 37614.247715045545, 37639.059023524635, 37744.73531588114, 37803.810980944916, 15848.52454426369, 15968.0, 15975.760363594556, 15988.920055399649, 16000.519984400487, 13130.934345328404, 13149.671258218621, 13171.93414032943, 13174.868251317364, 13345.866541334462, 8606.397552171413, 8662.78343041429, 8672.913270867337, 8690.695825646071, 8728.825423491622, 3398.150462384404, 3399.490076488497, 3399.6061614737837, 3412.3004784019217, 3443.8794642187404, 1141.6632093532428, 1163.5927425401042, 1203.072980821083, 1211.1098342718094, 1218.5004148299154, 33176.0, 33246.335073298396, 33599.664003359656, 33641.49537756936, 33811.4928276076, 1149.6436104807538, 1213.769383817072, 1260.174585646403, 1290.4386591832395, 1310.6330227536305, 17562.824371756375, 17608.55978600545, 17709.911450442665, 17750.11249437523, 17805.910970445064, 519672.0, 522282.0, 526582.0, 527336.0, 527360.0, 57604.71197643985, 58568.70715646395, 58713.0, 58980.0, 59109.40890591125, 1304.3608631770364, 1309.8231738715342, 1315.7368526294588, 1317.6771690935782, 1353.3706826325608, 31163.688363116984, 32204.0, 32619.0, 33241.83379083089, 33302.666973330925, 52460.73769631128, 52599.0, 52620.0, 52881.20678189907, 52891.206631901325, 408333.0, 409608.0, 409839.0, 409848.0, 412013.0, 28109.718902811528, 29315.85342073276, 29375.853120735115, 29380.853095734383, 29428.264293392836, 47061.294080589505, 48177.27871214512, 48187.27719084287, 48890.26664600105, 49820.25269620886, 40285.59714402819, 41467.37798933079, 41700.0, 41782.37326440166, 42705.0, 41069.84837186179, 41417.79291103525, 42180.15639687128, 42195.0, 42392.36411453769, 41696.0, 42128.57871421369, 42216.78891605522, 42882.78558607312, 43041.569584305005, 36466.63533364632, 37119.257614848095, 37217.81391093027, 37320.81339593285, 37755.811220944815, 28671.56992645154, 28882.71117288884, 29078.273043173245, 29295.85352073311, 29325.706742932296], "value": 18793.26912332977, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [402.4888391742489, 405.3838165987699, 405.7585736486789, 411.7879292164535, 416.2798358839208, 17931.372401965935, 19569.902150489244, 19596.0, 20073.397798066046, 20588.38234852953, 18707.158177881993, 18898.967938626065, 19126.0, 19632.312869049587, 19749.11128999195, 5507.917381239275, 5684.4315568443035, 5699.373068962411, 5723.599348045638, 5768.048272035109, 5525.475079867426, 5617.045102332593, 5661.46216109469, 5673.035583950717, 5703.686297253649, 5607.719614019303, 5660.066089095294, 5683.857903552403, 5688.687122208277, 5695.487406133447, 5489.39616642169, 5634.464725851038, 5666.744996475169, 5681.034224181899, 5699.515541179005, 4982.153033984231, 5059.139946209153, 5114.05390002847, 5127.5385215330425, 5181.922271165936, 22576.54846903069, 23106.537869242522, 23194.7680523196, 23347.066117355287, 23783.762162378327, 2481.739417361169, 2613.6210249513906, 2644.761971422562, 2795.496810574096, 2863.8854445822144, 14498.347574359179, 15632.765508517381, 15902.0, 16231.188440578042, 16536.586585335463, 2047.600717860003, 2143.2211264650305, 2171.2400659769114, 2186.365953873391, 2191.364504293753, 70447.64776176086, 82916.0, 89020.0, 90222.5488872558, 91761.54119229427, 17262.482125536255, 17491.650166996587, 17672.57441829279, 17757.289708411776, 17886.0, 32352.67647323544, 32381.35237295241, 32408.675913241037, 32534.83732581322, 32703.34593308168, 10213.846792298122, 10402.843957340647, 10764.407957562253, 10854.67435976922, 10858.0, 9035.322350823715, 9176.770580735534, 9197.77005574866, 9262.305327100494, 9341.813163736688, 9040.41237319572, 9214.493202873773, 9311.394759340621, 9366.812663746823, 9393.483358415217, 3463.8614455421502, 3582.910427239288, 3617.746757726934, 3642.417213245868, 3722.4788529605876, 924.426855349674, 996.3125443444001, 997.9950100249453, 1012.8379459286626, 1140.811766058591, 19110.044497775056, 19396.903015485113, 19604.509887252934, 19614.70577941332, 19775.40673779789, 1046.6441409920662, 1064.4890452582804, 1116.1015382616908, 1122.5846436818429, 1132.6828488023366, 10828.18788590843, 11105.38920359388, 11162.107031437628, 11264.0, 11297.0, 394949.0, 396991.0, 397561.0, 481807.0, 558875.0, 98804.5537950794, 100900.0, 101671.49164254131, 103465.48267258615, 103567.48216259021, 1073.27553901118, 1074.7098283463577, 1097.3415950429678, 1100.460774220626, 1116.4027245423658, 17604.29582816673, 17616.207270672596, 17627.0, 17728.556786079935, 17908.820911791237, 40690.59309406868, 41082.1783564333, 41238.38142427926, 41682.374764379165, 43168.35247471353, 59203.0, 59889.0, 59926.70036649963, 59960.0, 60153.398466014776, 7709.306162445407, 8696.56517174126, 8908.0, 8931.508767017876, 9107.544622768703, 12631.810522842348, 13543.0, 13687.452501899812, 13734.65663358424, 13846.792298115737, 11811.468483918072, 12091.455884485043, 12140.332281724237, 12440.813387799371, 12716.173448725804, 11977.101717371406, 12127.878721212675, 12170.939145304217, 12210.694732631755, 12218.45016974256, 11777.52889884395, 11946.940265298965, 12384.690382740504, 12492.063095268073, 12627.0, 8176.223258790405, 8185.590720464072, 8220.301274391744, 8222.424430289822, 8342.624581893951, 11955.916288692773, 12446.128770985944, 12488.43802028929, 12602.243865368107, 12789.42447589842], "value": 10317.121073922755, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1520.7414739494288, 1571.1751330551463, 1719.4497760716567, 1801.5676237702955, 1834.7981722010584, 7655.808604784883, 8101.270885620293, 8159.428839981197, 8771.166739159778, 8771.912280877197, 8253.215944485264, 8325.29235015023, 8335.0, 8377.120402357756, 8408.747737567883, 2312.629979203328, 2331.743508214095, 2353.4351755578623, 2353.49399879026, 2359.55168517981, 2267.093162734911, 2296.942576435594, 2325.500017496238, 2338.8012018978407, 2344.038944032947, 2269.5687819314276, 2284.1776960294283, 2307.457747429353, 2331.0209711920947, 2340.602097643396, 2267.489814791667, 2298.586254474194, 2300.7009088818513, 2304.43541332373, 2314.2247347138727, 2274.5337205872756, 2294.288770481156, 2298.908043678251, 2306.6655334976504, 2314.8148148148107, 8365.581720913991, 8420.8315833683, 8424.4945303282, 8465.068842427328, 8523.872141917876, 5092.26162206478, 5161.741912904377, 5167.121589329823, 5181.248718935733, 5188.688678679291, 3319.1038419626566, 3343.3814744272145, 3368.242145517239, 3488.197714525648, 3567.8929632110817, 1071.287593750155, 1109.944502774858, 1115.380963565221, 1131.8019346614392, 1136.1308598921748, 11861.52553897843, 11870.584529541424, 11927.880721192763, 11938.761224775542, 11951.521939122425, 4513.72917624937, 4581.083783243298, 4602.424696912886, 4742.407199100113, 4756.738379389098, 9456.243500519942, 9476.0, 9502.049795020443, 9524.571394287274, 9547.856782148274, 5162.664426812245, 5168.819091331786, 5198.714070726146, 5204.7918083276245, 5206.167013277933, 4234.06850492891, 4729.125111854318, 4854.2233242681, 4858.58702010333, 4876.975615121973, 3709.647583479565, 3712.7586706863967, 3808.923821523554, 3826.521684789401, 3855.63371479709, 1122.141561705296, 1141.1612464838338, 1149.83327417524, 1152.6657269391783, 1155.5493357590378, 959.5154447004218, 1046.9162467002623, 1059.750958524746, 1073.066432203972, 1078.1751959750798, 6025.517958563304, 6172.722227499773, 6178.104174894615, 6238.033104868752, 6319.494440444753, 432.22631489633204, 433.8091239854454, 438.6819555822004, 441.0825482995362, 445.1586501512145, 4114.7942602870335, 4182.456280683492, 4228.281192197333, 4271.6369108625495, 4286.699931004862, 10409.115225205942, 10510.264281500375, 10746.194035447374, 10752.838707419394, 10820.188485863591, 10670.946645266724, 10672.146228301717, 10700.197485188643, 10767.97704218098, 10773.299735517323, 7862.095858976291, 7875.6062196889925, 7940.563269020144, 8075.919240807634, 8108.067572229269, 5890.352061273171, 5943.554233432596, 5989.670568118795, 6021.488173505126, 6090.756369745161, 9760.804783904141, 9826.312158149147, 9897.703068907944, 9949.204063675033, 10007.449590272605, 9383.577739001625, 9804.85292720624, 9821.312508124363, 10029.097381235724, 10108.090271875566, 7212.42300615939, 7453.403727701662, 7627.351675107678, 7723.0, 7738.303552680286, 8438.873416898628, 8483.024452188078, 8539.359548033797, 8576.0, 8621.180987806149, 7619.619019048914, 7846.882296765439, 7862.52824830512, 7893.250141236574, 7900.4074694397, 7490.925090749241, 7629.122650895218, 7653.0867283179205, 7656.73201437947, 7657.961710191414, 6714.0600315954825, 6749.763758268437, 6806.76176333826, 6815.148106486689, 6840.213375461686, 5119.488051195, 5200.349956255468, 5297.788088476418, 5300.496452836975, 5334.599905007062, 5098.413682426569, 5114.105031619526, 5154.639175257696, 5339.652922560022, 5407.567394608501], "value": 4497.424780777045, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.8511169973511, 335.7297375612632, 336.4179968654228, 343.3322188343671, 344.76728208459286, 5432.402435732071, 5551.0, 5555.694436805984, 5569.554435645149, 5613.270274864267, 5483.835484935458, 5485.6960076767755, 5491.533219676332, 5493.890122197554, 5521.742172118449, 4070.633642972132, 4169.812358443877, 4288.828446862121, 4303.891093364245, 4315.525292217853, 4235.3646952957, 4262.616364527207, 4272.209641216369, 4280.657547396201, 4303.526612072669, 4224.176285624305, 4224.471941007374, 4240.194363071022, 4262.680298977589, 4278.61492465678, 3992.660623846991, 4284.8859296582805, 4285.185814695214, 4286.807093680761, 4293.570642935712, 3740.7007439405056, 3743.2139250757373, 3760.157522813829, 3761.4545890845675, 3762.8682996095004, 5328.600354973392, 5337.263915259334, 5348.251244825728, 5354.705491197982, 5356.276902618136, 4589.334546490773, 4821.204501257288, 4840.733759643218, 4888.266759985995, 4904.5340692634145, 5651.7739290428335, 5653.406392328788, 5687.40282270364, 5698.772049118031, 5740.0, 4037.0109323215706, 4083.8979025524304, 4100.958990410088, 4112.753234805921, 4124.092699606082, 5766.452187042224, 5976.4919981801595, 5977.22296101504, 5977.671228082454, 6025.457708806184, 4162.854300099482, 4178.603032711888, 4190.141021090669, 4199.286121359376, 4205.789710514462, 4167.541570427251, 4190.0, 4191.350340697197, 4241.384999175102, 4246.766427846498, 4655.348251244828, 4783.808647654055, 4785.569298763128, 4813.975930120327, 4824.517548245148, 5678.716064196774, 5679.31848178213, 5683.346415162227, 5700.942990570041, 5731.971340143356, 1410.5486244401898, 1422.3741553716332, 1425.759589157419, 1427.2435609127178, 1427.5289154578963, 904.2539904578749, 913.8263729891299, 966.5264020629841, 986.2898712926682, 1001.3191030099603, 5307.946920530745, 5342.572594192456, 5402.0, 5458.9454105458435, 5478.123500239943, 5628.802991895264, 5649.435056494318, 5690.5163061140265, 5716.256886604798, 5734.426557344233, 5228.660137091077, 5361.919571206435, 5372.382176049726, 5402.810901618424, 5456.427075157131, 3028.545718142296, 3054.6487153977578, 3056.419280336729, 3060.7704422168426, 3071.401076790049, 5612.579056570692, 5845.181674565564, 5947.732352044169, 5958.6424814511265, 6063.787767428119, 5811.244538210006, 5831.279772467133, 5838.970805145947, 5848.753941562389, 5868.589198756046, 5841.853953651108, 5842.620229685057, 5896.3219229788265, 5901.0, 5909.172715819789, 5517.36550296721, 5536.031194541019, 5612.214289999321, 5686.09022556389, 5695.544356451557, 5549.916751248654, 5579.553635709215, 5591.888162236651, 5615.522680572197, 5633.042382795016, 5609.4390560943575, 5808.0, 5852.736626851717, 5878.853028674317, 5897.941020589739, 3998.9600103998587, 4000.6199411055904, 4011.1777085697945, 4015.6909776878997, 4037.333839916381, 5657.688827114548, 5778.393268706894, 5800.390958949419, 5842.130518234294, 5865.384134665798, 5461.9453805461435, 5552.750126244248, 5688.744006519633, 5695.45893140151, 5722.427757224411, 5504.724763761876, 5545.694986775605, 5577.860553486195, 5607.5513958884, 5612.540739407702, 5455.509004189642, 5476.452354764491, 5513.421090785409, 5567.164925261243, 5626.915596265977, 5734.3692193857805, 5796.739146738491, 5813.94186058134, 5821.330546986981, 5842.737076831468, 5665.150227465913, 5683.147527870852, 5703.458171473703, 5704.0, 5712.942870571407], "value": 4313.725029635763, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [751.9285667861554, 773.8452309538092, 781.1251398433755, 791.924767147121, 805.2108933245423, 14150.22173780443, 14397.64005899853, 14792.556223313291, 14936.0, 14963.476278330261, 14070.788938165935, 14071.0, 14133.646658833535, 14157.0, 14182.503612373568, 796.7012370361115, 818.7666515043214, 834.1366685480529, 845.4589062999685, 846.6232526525667, 836.0970152235572, 842.4987132656059, 842.6292431330226, 843.9409241353077, 846.4032856835946, 881.4138597832434, 881.8192270584547, 882.0, 882.1178821178821, 884.5311984648147, 872.3893274707698, 875.8511053120985, 876.4741155306829, 877.0440220160025, 877.4603618774472, 640.2445114764575, 640.9903851442232, 643.5623775832432, 644.3878315600199, 645.5448908519529, 14409.423623055065, 14516.274186290642, 14525.78211326831, 14555.490557830424, 14586.270686465741, 13740.793888091686, 13834.169949803045, 13863.098898571561, 13877.583672489842, 13976.440942362293, 11373.374464404455, 11464.923868455842, 11567.42162891852, 11658.183927125105, 11794.233374830608, 3856.749311294757, 3873.593272706353, 3911.0, 3926.371780515104, 4041.4544036555276, 57028.42971570314, 57101.42898571002, 57432.71283643597, 57492.425075749125, 57903.71048144774, 10808.945955270174, 10825.0, 10862.34004020138, 10972.506237219344, 11173.329600224013, 19072.71390929137, 19072.90463547701, 19090.904545477184, 19121.61756764857, 19164.61670766577, 8153.388495862834, 8359.289460395934, 8364.247217750431, 8424.199701028392, 8649.351298652626, 4790.640701947298, 4888.388951381077, 4888.584470320063, 5032.874178145576, 5094.5160209780015, 3318.6515415881468, 3420.4698271767916, 3421.196018935548, 3423.7432192585156, 3430.7255419566377, 598.1207624791549, 608.8934436473688, 611.8745657140275, 615.1756646094166, 618.7153909201818, 735.2059775442509, 743.3495691270139, 759.7189040055215, 784.9489783164076, 799.8640231160716, 9590.328676992543, 9593.712188634352, 9677.838659360781, 9696.75758106053, 9921.851172232422, 763.5495057915856, 780.7813812132612, 791.1258059843905, 794.1899262751961, 796.8645330293864, 4620.006698559759, 4627.8843028923875, 4747.311639812277, 4752.811162310816, 4899.118158731462, 62075.37924620696, 64805.0, 65682.0, 65783.34216657867, 65914.0, 57495.26280791735, 58612.7069364659, 59279.40720592825, 59387.70306148442, 59834.0, 53182.0, 53462.19806702903, 53463.46536534585, 53499.46500534945, 53883.19175212375, 9313.70122090084, 9325.86011209846, 9391.107844754737, 9437.764055898382, 9454.290928180277, 32587.0, 33007.83496082504, 33833.0, 33882.66117338795, 34164.31671366509, 44406.55593444024, 46908.29637555371, 47421.52578474309, 47446.76276618595, 47942.28086578774, 11027.22809403334, 11248.212625116163, 11342.829857551978, 11449.828252576051, 11557.0, 12718.364081795688, 13079.738405232032, 13168.736625267633, 13196.472141114247, 13914.582562523141, 11392.373419462008, 12108.335116361215, 12174.33041182708, 12174.634760957186, 12189.207701499374, 12628.368581570701, 12923.22460652364, 13255.0, 13276.0, 13322.134061285986, 12014.459349329476, 12325.383730813603, 12515.0, 12581.93709031449, 12687.492500299884, 10019.799604008025, 10091.293609447563, 10402.115820155372, 10767.515461804081, 10830.350178989285, 9705.369151005161, 10143.847842282225, 10301.74245643865, 10374.377537347784, 10386.636467723594], "value": 6872.341614597353, "unit": "score"}], "name": "dromaeo_css", "value": 7190.97916474915, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 113.0, 105.0, 112.0, 112.0, 114.0, 106.0, 110.0, 114.0, 114.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 127.0, 152.0, 181.0, 125.0, 150.0, 150.0, 133.0, 194.0, 134.0], "value": 149.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 171.0, 166.0, 162.0, 164.0, 166.0, 171.0, 162.0, 163.0, 161.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 74.0, 153.0, 78.0, 76.0, 75.0, 76.0, 163.0, 76.0], "value": 92.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 146.0, 92.0, 92.0, 94.0, 146.0, 92.0, 93.0, 159.0], "value": 109.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 147.0, 147.0, 147.0, 147.0, 149.0, 147.0, 148.0, 148.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 56.0, 56.0, 58.0, 58.0, 57.0, 76.0, 57.0, 59.0], "value": 59.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 59.0, 59.0, 58.0, 58.0, 58.0, 59.0, 58.0, 58.0], "value": 58.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 80.0, 79.0, 79.0, 83.0, 90.0, 78.0, 78.0, 79.0, 79.0], "value": 80.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 127.0, 125.0, 125.0, 131.0, 131.0, 124.0, 134.0, 161.0, 124.0], "value": 131.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 172.0, 165.0, 176.0, 171.0, 165.0, 167.0, 166.0, 165.0, 165.0], "value": 168.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 70.0, 65.0, 64.0, 64.0, 67.0, 63.0, 64.0, 65.0, 63.0], "value": 65.1, "unit": "score"}], "name": "kraken", "value": 1550.9, "alertThreshold": 2.0}]} 02:23:31 INFO - Return code: 0 02:23:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:23:31 ERROR - # TBPL SUCCESS # 02:23:31 INFO - Running post-action listener: _resource_record_post_action 02:23:31 INFO - Running post-run listener: _resource_record_post_run 02:23:32 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 7831552; Write bytes: 495710208; Read time: 1856; Write time: 361572 02:23:32 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 78917632; Read time: 0; Write time: 38124 02:23:32 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 5963776; Write bytes: 416792576; Read time: 1308; Write time: 323448 02:23:32 INFO - Running post-run listener: _upload_blobber_files 02:23:32 INFO - Blob upload gear active. 02:23:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:23:32 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 02:23:32 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:23:32 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:23:32 INFO - (blobuploader) - INFO - Open directory for files ... 02:23:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:23:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:23:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:23:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:23:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:23:33 INFO - (blobuploader) - INFO - Done attempting. 02:23:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:23:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:23:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:23:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:23:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:23:34 INFO - (blobuploader) - INFO - Done attempting. 02:23:34 INFO - (blobuploader) - INFO - Iteration through files over. 02:23:34 INFO - Return code: 0 02:23:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:23:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:23:34 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/07a4c79f73e59b011995d789c781f80714a194489d4d64cc2ab40ca0e89a17bf4ec220fd024f63b83e93a034a3000dcc263200e74d68ffc33f18c13c8221f532", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3d0ba967ed115ae19e7e3ae875d796cfbf494698c554f2bbadef8a6033f2cddd45e3c07475cf2b520e503a603ef2f020780f5dcbc27c10bc20615a6b18f5c701"} 02:23:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:23:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:23:34 INFO - Contents: 02:23:34 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/07a4c79f73e59b011995d789c781f80714a194489d4d64cc2ab40ca0e89a17bf4ec220fd024f63b83e93a034a3000dcc263200e74d68ffc33f18c13c8221f532", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3d0ba967ed115ae19e7e3ae875d796cfbf494698c554f2bbadef8a6033f2cddd45e3c07475cf2b520e503a603ef2f020780f5dcbc27c10bc20615a6b18f5c701"} 02:23:34 INFO - Running post-run listener: copy_logs_to_upload_dir 02:23:34 INFO - Copying logs to upload dir... 02:23:34 INFO - mkdir: /builds/slave/test/build/upload/logs 02:23:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.862399 ========= master_lag: 0.25 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-05-06 02:23:34.431596) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 02:23:34.435386) ========= 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=7cf709767345e0a0c5a90e72000001d4-1462525156.380733-2130376568 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/sha512/07a4c79f73e59b011995d789c781f80714a194489d4d64cc2ab40ca0e89a17bf4ec220fd024f63b83e93a034a3000dcc263200e74d68ffc33f18c13c8221f532", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3d0ba967ed115ae19e7e3ae875d796cfbf494698c554f2bbadef8a6033f2cddd45e3c07475cf2b520e503a603ef2f020780f5dcbc27c10bc20615a6b18f5c701"} build_url:https://queue.taskcluster.net/v1/task/fnlcXiXnTKihk3YFUTwXRw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011109 build_url: 'https://queue.taskcluster.net/v1/task/fnlcXiXnTKihk3YFUTwXRw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/07a4c79f73e59b011995d789c781f80714a194489d4d64cc2ab40ca0e89a17bf4ec220fd024f63b83e93a034a3000dcc263200e74d68ffc33f18c13c8221f532", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3d0ba967ed115ae19e7e3ae875d796cfbf494698c554f2bbadef8a6033f2cddd45e3c07475cf2b520e503a603ef2f020780f5dcbc27c10bc20615a6b18f5c701"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-06 02:23:34.459516) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 02:23:34.459847) ========= 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=7cf709767345e0a0c5a90e72000001d4-1462525156.380733-2130376568 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004360 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-06 02:23:34.542259) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 02:23:34.542562) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-06 02:23:34.543002) ========= ========= Total master_lag: 0.41 =========