builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-014 starttime: 1461592915.61 results: success (0) buildid: 20160425053553 builduid: 1d95cc054ffb4593add8611da7987a93 revision: 0f07f975526f3abda2f997bbb2feb0a25f771227 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 07:01:55.610353) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 07:01:55.610903) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 07:01:55.611205) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 07:01:55.628624) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 07:01:55.629019) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1461592915.310445-2046670663 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-25 07:01:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.5M=0s 2016-04-25 07:01:56 (43.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.089401 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 07:01:55.732216) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 07:01:55.732558) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1461592915.310445-2046670663 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019592 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 07:01:55.781473) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 07:01:55.781829) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0f07f975526f3abda2f997bbb2feb0a25f771227 --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 0f07f975526f3abda2f997bbb2feb0a25f771227 --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=fa9c93d544b966bd2b8d485a000001c6-1461592915.310445-2046670663 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-25 07:01:56,174 truncating revision to first 12 chars 2016-04-25 07:01:56,174 Setting DEBUG logging. 2016-04-25 07:01:56,174 attempt 1/10 2016-04-25 07:01:56,174 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0f07f975526f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-25 07:01:56,670 unpacking tar archive at: fx-team-0f07f975526f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.824213 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 07:01:56.677154) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 07:01:56.677637) ========= script_repo_revision: 0f07f975526f3abda2f997bbb2feb0a25f771227 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 07:01:56.678243) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 07:01:56.678697) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 07:01:56.689447) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-04-25 07:01:56.689858) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa9c93d544b966bd2b8d485a000001c6-1461592915.310445-2046670663 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:01:57 INFO - MultiFileLogger online at 20160425 07:01:57 in /builds/slave/test 07:01:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 07:01:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:01:57 INFO - {'append_to_log': False, 07:01:57 INFO - 'base_work_dir': '/builds/slave/test', 07:01:57 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 07:01:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:01:57 INFO - 'branch': 'Fx-Team-Non-PGO', 07:01:57 INFO - 'buildbot_json_path': 'buildprops.json', 07:01:57 INFO - 'config_files': ('talos/linux_config.py',), 07:01:57 INFO - 'default_actions': ('clobber', 07:01:57 INFO - 'read-buildbot-config', 07:01:57 INFO - 'download-and-extract', 07:01:57 INFO - 'populate-webroot', 07:01:57 INFO - 'create-virtualenv', 07:01:57 INFO - 'install', 07:01:57 INFO - 'run-tests'), 07:01:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:01:57 INFO - 'download_minidump_stackwalk': True, 07:01:57 INFO - 'download_symbols': 'ondemand', 07:01:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:01:57 INFO - 'tooltool.py': '/tools/tooltool.py', 07:01:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:01:57 INFO - '/tools/misc-python/virtualenv.py')}, 07:01:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:01:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:01:57 INFO - 'installer_path': 'installer.exe', 07:01:57 INFO - 'log_level': 'info', 07:01:57 INFO - 'log_name': 'talos', 07:01:57 INFO - 'log_to_console': True, 07:01:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:01:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:01:57 INFO - 'opt_config_files': (), 07:01:57 INFO - 'pip_index': False, 07:01:57 INFO - 'sps_profile': False, 07:01:57 INFO - 'sps_profile_interval': 0, 07:01:57 INFO - 'suite': 'dromaeojs-e10s', 07:01:57 INFO - 'system_bits': '32', 07:01:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:01:57 INFO - 'title': 'talos-linux64-ix-014', 07:01:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:01:57 INFO - 'use_talos_json': True, 07:01:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:01:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:01:57 INFO - 'work_dir': 'build'} 07:01:57 INFO - ##### 07:01:57 INFO - ##### Running clobber step. 07:01:57 INFO - ##### 07:01:57 INFO - Running pre-action listener: _resource_record_pre_action 07:01:57 INFO - Running main action method: clobber 07:01:57 INFO - rmtree: /builds/slave/test/build 07:01:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:01:57 INFO - Running post-action listener: _resource_record_post_action 07:01:57 INFO - ##### 07:01:57 INFO - ##### Running read-buildbot-config step. 07:01:57 INFO - ##### 07:01:57 INFO - Running pre-action listener: _resource_record_pre_action 07:01:57 INFO - Running main action method: read_buildbot_config 07:01:57 INFO - Using buildbot properties: 07:01:57 INFO - { 07:01:57 INFO - "project": "", 07:01:57 INFO - "product": "firefox", 07:01:57 INFO - "script_repo_revision": "production", 07:01:57 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 07:01:57 INFO - "repository": "", 07:01:57 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 07:01:57 INFO - "buildid": "20160425053553", 07:01:57 INFO - "pgo_build": "False", 07:01:57 INFO - "basedir": "/builds/slave/test", 07:01:57 INFO - "buildnumber": 1207, 07:01:57 INFO - "slavename": "talos-linux64-ix-014", 07:01:57 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:01:57 INFO - "platform": "ubuntu64_hw", 07:01:57 INFO - "scheduler": "tests-fx-team-linux64-talos", 07:01:57 INFO - "branch": "fx-team", 07:01:57 INFO - "repo_path": "integration/fx-team", 07:01:57 INFO - "revision": "0f07f975526f3abda2f997bbb2feb0a25f771227", 07:01:57 INFO - "stage_platform": "linux64", 07:01:57 INFO - "builduid": "1d95cc054ffb4593add8611da7987a93", 07:01:57 INFO - "slavebuilddir": "test" 07:01:57 INFO - } 07:01:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/OMTqYplySRKqVp28AOG53Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 07:01:57 INFO - Running post-action listener: _resource_record_post_action 07:01:57 INFO - ##### 07:01:57 INFO - ##### Running download-and-extract step. 07:01:57 INFO - ##### 07:01:57 INFO - Running pre-action listener: _resource_record_pre_action 07:01:57 INFO - Running main action method: download_and_extract 07:01:57 INFO - mkdir: /builds/slave/test/build/tests 07:01:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:57 INFO - https://queue.taskcluster.net/v1/task/OMTqYplySRKqVp28AOG53Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:01:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OMTqYplySRKqVp28AOG53Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:01:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OMTqYplySRKqVp28AOG53Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:01:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OMTqYplySRKqVp28AOG53Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:01:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OMTqYplySRKqVp28AOG53Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:01:58 INFO - Downloaded 1361 bytes. 07:01:58 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:01:58 INFO - Using the following test package requirements: 07:01:58 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 07:01:58 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:01:58 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:01:58 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:01:58 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:01:58 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:01:58 INFO - u'jsshell-linux-x86_64.zip'], 07:01:58 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:01:58 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:01:58 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 07:01:58 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:01:58 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:01:58 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:01:58 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:01:58 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:01:58 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:01:58 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:01:58 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:01:58 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:01:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:58 INFO - https://queue.taskcluster.net/v1/task/OMTqYplySRKqVp28AOG53Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:01:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OMTqYplySRKqVp28AOG53Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:01:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OMTqYplySRKqVp28AOG53Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:01:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OMTqYplySRKqVp28AOG53Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:01:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OMTqYplySRKqVp28AOG53Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:02:00 INFO - Downloaded 22288052 bytes. 07:02:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:02:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:02:01 INFO - Return code: 0 07:02:01 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:02:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:02:01 INFO - https://queue.taskcluster.net/v1/task/OMTqYplySRKqVp28AOG53Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:02:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OMTqYplySRKqVp28AOG53Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:02:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OMTqYplySRKqVp28AOG53Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:02:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OMTqYplySRKqVp28AOG53Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:02:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OMTqYplySRKqVp28AOG53Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:02:02 INFO - Downloaded 22288052 bytes. 07:02:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:02:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:02:04 INFO - Return code: 0 07:02:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:02:04 INFO - https://queue.taskcluster.net/v1/task/OMTqYplySRKqVp28AOG53Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:02:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OMTqYplySRKqVp28AOG53Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:02:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OMTqYplySRKqVp28AOG53Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:02:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OMTqYplySRKqVp28AOG53Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:02:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OMTqYplySRKqVp28AOG53Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:02:05 INFO - Downloaded 10840145 bytes. 07:02:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:02:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:02:05 INFO - Return code: 0 07:02:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:02:05 INFO - https://queue.taskcluster.net/v1/task/OMTqYplySRKqVp28AOG53Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:02:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OMTqYplySRKqVp28AOG53Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:02:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OMTqYplySRKqVp28AOG53Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:02:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OMTqYplySRKqVp28AOG53Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:02:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OMTqYplySRKqVp28AOG53Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:02:06 INFO - Downloaded 54814846 bytes. 07:02:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OMTqYplySRKqVp28AOG53Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:02:06 INFO - mkdir: /builds/slave/test/properties 07:02:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:02:06 INFO - Writing to file /builds/slave/test/properties/build_url 07:02:06 INFO - Contents: 07:02:06 INFO - build_url:https://queue.taskcluster.net/v1/task/OMTqYplySRKqVp28AOG53Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:02:07 INFO - Running post-action listener: _resource_record_post_action 07:02:07 INFO - Running post-action listener: set_extra_try_arguments 07:02:07 INFO - ##### 07:02:07 INFO - ##### Running populate-webroot step. 07:02:07 INFO - ##### 07:02:07 INFO - Running pre-action listener: _resource_record_pre_action 07:02:07 INFO - Running main action method: populate_webroot 07:02:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:02:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:02:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:02:07 INFO - '--tppagecycles', 07:02:07 INFO - '7'], 07:02:07 INFO - 'tests': ['tsvgm']}}, 07:02:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:02:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:02:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:02:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:02:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:02:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:02:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:02:07 INFO - 'talos_options': ['--disable-e10s'], 07:02:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:02:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:02:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:02:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:02:07 INFO - 'talos_options': ['--disable-e10s'], 07:02:07 INFO - 'tests': ['damp', 'tps']}, 07:02:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:02:07 INFO - 'tests': ['damp', 'tps']}, 07:02:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:02:07 INFO - 'tests': ['dromaeo_dom']}, 07:02:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:02:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:02:07 INFO - 'tests': ['a11yr', 07:02:07 INFO - 'ts_paint', 07:02:07 INFO - 'tpaint', 07:02:07 INFO - 'sessionrestore', 07:02:07 INFO - 'sessionrestore_no_auto_restore', 07:02:07 INFO - 'tabpaint']}, 07:02:07 INFO - 'other-e10s': {'tests': ['a11yr', 07:02:07 INFO - 'ts_paint', 07:02:07 INFO - 'tpaint', 07:02:07 INFO - 'sessionrestore', 07:02:07 INFO - 'sessionrestore_no_auto_restore', 07:02:07 INFO - 'tabpaint']}, 07:02:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:02:07 INFO - 'ts_paint', 07:02:07 INFO - 'tpaint', 07:02:07 INFO - 'sessionrestore', 07:02:07 INFO - 'sessionrestore_no_auto_restore', 07:02:07 INFO - 'tabpaint']}, 07:02:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:02:07 INFO - 'ts_paint', 07:02:07 INFO - 'tpaint', 07:02:07 INFO - 'sessionrestore', 07:02:07 INFO - 'sessionrestore_no_auto_restore', 07:02:07 INFO - 'tabpaint']}, 07:02:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:02:07 INFO - 'tests': ['a11yr', 07:02:07 INFO - 'ts_paint', 07:02:07 INFO - 'tpaint', 07:02:07 INFO - 'sessionrestore', 07:02:07 INFO - 'sessionrestore_no_auto_restore', 07:02:07 INFO - 'tabpaint']}, 07:02:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:02:07 INFO - 'tests': ['a11yr', 07:02:07 INFO - 'ts_paint', 07:02:07 INFO - 'tpaint', 07:02:07 INFO - 'sessionrestore', 07:02:07 INFO - 'sessionrestore_no_auto_restore', 07:02:07 INFO - 'tabpaint']}, 07:02:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:02:07 INFO - 'tests': ['tsvgx', 07:02:07 INFO - 'tsvgr_opacity', 07:02:07 INFO - 'tart', 07:02:07 INFO - 'tscrollx', 07:02:07 INFO - 'cart']}, 07:02:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:02:07 INFO - 'tsvgr_opacity', 07:02:07 INFO - 'tart', 07:02:07 INFO - 'tscrollx', 07:02:07 INFO - 'cart']}, 07:02:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:02:07 INFO - 'talos_options': ['--disable-e10s'], 07:02:07 INFO - 'tests': ['tp5o']}, 07:02:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:02:07 INFO - 'tests': ['tp5o']}, 07:02:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:02:07 INFO - 'talos_options': ['--disable-e10s', 07:02:07 INFO - '--xperf_path', 07:02:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:02:07 INFO - 'tests': ['tp5n']}, 07:02:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:02:07 INFO - 'talos_options': ['--xperf_path', 07:02:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:02:07 INFO - 'tests': ['tp5n']}}, 07:02:07 INFO - 'talos.zip': {'path': '', 07:02:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:02:07 INFO - Running post-action listener: _resource_record_post_action 07:02:07 INFO - ##### 07:02:07 INFO - ##### Running create-virtualenv step. 07:02:07 INFO - ##### 07:02:07 INFO - Running pre-action listener: _resource_record_pre_action 07:02:07 INFO - Running main action method: create_virtualenv 07:02:07 INFO - Creating virtualenv /builds/slave/test/build/venv 07:02:07 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:02:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:02:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:02:07 INFO - Using real prefix '/usr' 07:02:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:02:08 INFO - Installing distribute.............................................................................................................................................................................................done. 07:02:10 INFO - Installing pip.................done. 07:02:10 INFO - Return code: 0 07:02:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:02:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:02:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:10 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 0x7fe4df68af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13325a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c1410>, '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 0x13c2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13c27a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461592915.310445-2046670663', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:02:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:02:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:02:10 INFO - Using env: {'DISPLAY': ':0', 07:02:10 INFO - 'HOME': '/home/cltbld', 07:02:10 INFO - 'LANG': 'en_US.UTF-8', 07:02:10 INFO - 'LANGUAGE': 'en_US:en', 07:02:10 INFO - 'LOGNAME': 'cltbld', 07:02:10 INFO - 'MAIL': '/var/mail/cltbld', 07:02:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:10 INFO - 'MOZ_NO_REMOTE': '1', 07:02:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:10 INFO - 'NO_EM_RESTART': '1', 07:02:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:02:10 INFO - 'PWD': '/builds/slave/test', 07:02:10 INFO - 'SHELL': '/bin/bash', 07:02:10 INFO - 'SHLVL': '1', 07:02:10 INFO - 'TERM': 'linux', 07:02:10 INFO - 'TMOUT': '86400', 07:02:10 INFO - 'USER': 'cltbld', 07:02:10 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461592915.310445-2046670663', 07:02:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:10 INFO - '_': '/tools/buildbot/bin/python'} 07:02:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:10 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:02:10 INFO - Cleaning up... 07:02:10 INFO - Return code: 0 07:02:10 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:02:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:02:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:10 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 0x7fe4df68af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13325a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c1410>, '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 0x13c2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13c27a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461592915.310445-2046670663', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:02:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 07:02:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 07:02:10 INFO - Using env: {'DISPLAY': ':0', 07:02:10 INFO - 'HOME': '/home/cltbld', 07:02:10 INFO - 'LANG': 'en_US.UTF-8', 07:02:10 INFO - 'LANGUAGE': 'en_US:en', 07:02:10 INFO - 'LOGNAME': 'cltbld', 07:02:10 INFO - 'MAIL': '/var/mail/cltbld', 07:02:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:10 INFO - 'MOZ_NO_REMOTE': '1', 07:02:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:10 INFO - 'NO_EM_RESTART': '1', 07:02:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:02:10 INFO - 'PWD': '/builds/slave/test', 07:02:10 INFO - 'SHELL': '/bin/bash', 07:02:10 INFO - 'SHLVL': '1', 07:02:10 INFO - 'TERM': 'linux', 07:02:10 INFO - 'TMOUT': '86400', 07:02:10 INFO - 'USER': 'cltbld', 07:02:10 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461592915.310445-2046670663', 07:02:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:10 INFO - '_': '/tools/buildbot/bin/python'} 07:02:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:10 INFO - Downloading/unpacking psutil>=0.7.1 07:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:02:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:02:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:02:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:02:12 INFO - Installing collected packages: psutil 07:02:12 INFO - Running setup.py install for psutil 07:02:12 INFO - building 'psutil._psutil_linux' extension 07:02:12 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:02:13 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:02:13 INFO - building 'psutil._psutil_posix' extension 07:02:13 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:02:13 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:02:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:02:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:02:13 INFO - Successfully installed psutil 07:02:13 INFO - Cleaning up... 07:02:13 INFO - Return code: 0 07:02:13 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:02:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:02:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:02:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe4df68af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13325a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c1410>, '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 0x13c2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13c27a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461592915.310445-2046670663', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:02:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 07:02:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 07:02:13 INFO - Using env: {'DISPLAY': ':0', 07:02:13 INFO - 'HOME': '/home/cltbld', 07:02:13 INFO - 'LANG': 'en_US.UTF-8', 07:02:13 INFO - 'LANGUAGE': 'en_US:en', 07:02:13 INFO - 'LOGNAME': 'cltbld', 07:02:13 INFO - 'MAIL': '/var/mail/cltbld', 07:02:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:13 INFO - 'MOZ_NO_REMOTE': '1', 07:02:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:13 INFO - 'NO_EM_RESTART': '1', 07:02:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:02:13 INFO - 'PWD': '/builds/slave/test', 07:02:13 INFO - 'SHELL': '/bin/bash', 07:02:13 INFO - 'SHLVL': '1', 07:02:13 INFO - 'TERM': 'linux', 07:02:13 INFO - 'TMOUT': '86400', 07:02:13 INFO - 'USER': 'cltbld', 07:02:13 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461592915.310445-2046670663', 07:02:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:13 INFO - '_': '/tools/buildbot/bin/python'} 07:02:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:13 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:02:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:02:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:02:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:15 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:02:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:02:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:02:15 INFO - Installing collected packages: mozsystemmonitor 07:02:15 INFO - Running setup.py install for mozsystemmonitor 07:02:15 INFO - Successfully installed mozsystemmonitor 07:02:15 INFO - Cleaning up... 07:02:15 INFO - Return code: 0 07:02:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:02:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:02:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:02:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe4df68af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13325a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c1410>, '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 0x13c2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13c27a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461592915.310445-2046670663', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:02:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:02:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:02:15 INFO - Using env: {'DISPLAY': ':0', 07:02:15 INFO - 'HOME': '/home/cltbld', 07:02:15 INFO - 'LANG': 'en_US.UTF-8', 07:02:15 INFO - 'LANGUAGE': 'en_US:en', 07:02:15 INFO - 'LOGNAME': 'cltbld', 07:02:15 INFO - 'MAIL': '/var/mail/cltbld', 07:02:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:15 INFO - 'MOZ_NO_REMOTE': '1', 07:02:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:15 INFO - 'NO_EM_RESTART': '1', 07:02:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:02:15 INFO - 'PWD': '/builds/slave/test', 07:02:15 INFO - 'SHELL': '/bin/bash', 07:02:15 INFO - 'SHLVL': '1', 07:02:15 INFO - 'TERM': 'linux', 07:02:15 INFO - 'TMOUT': '86400', 07:02:15 INFO - 'USER': 'cltbld', 07:02:15 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461592915.310445-2046670663', 07:02:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:15 INFO - '_': '/tools/buildbot/bin/python'} 07:02:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:15 INFO - Downloading/unpacking blobuploader==1.2.4 07:02:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:02:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:02:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:17 INFO - Downloading blobuploader-1.2.4.tar.gz 07:02:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:02:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:02:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:02:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:02:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:02:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:02:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:02:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:02:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:18 INFO - Downloading docopt-0.6.1.tar.gz 07:02:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:02:18 INFO - Installing collected packages: blobuploader, requests, docopt 07:02:18 INFO - Running setup.py install for blobuploader 07:02:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:02:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:02:18 INFO - Running setup.py install for requests 07:02:18 INFO - Running setup.py install for docopt 07:02:18 INFO - Successfully installed blobuploader requests docopt 07:02:18 INFO - Cleaning up... 07:02:19 INFO - Return code: 0 07:02:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:02:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:02:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:19 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 0x7fe4df68af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13325a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c1410>, '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 0x13c2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13c27a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461592915.310445-2046670663', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:02:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:02:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:02:19 INFO - Using env: {'DISPLAY': ':0', 07:02:19 INFO - 'HOME': '/home/cltbld', 07:02:19 INFO - 'LANG': 'en_US.UTF-8', 07:02:19 INFO - 'LANGUAGE': 'en_US:en', 07:02:19 INFO - 'LOGNAME': 'cltbld', 07:02:19 INFO - 'MAIL': '/var/mail/cltbld', 07:02:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:19 INFO - 'MOZ_NO_REMOTE': '1', 07:02:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:19 INFO - 'NO_EM_RESTART': '1', 07:02:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:02:19 INFO - 'PWD': '/builds/slave/test', 07:02:19 INFO - 'SHELL': '/bin/bash', 07:02:19 INFO - 'SHLVL': '1', 07:02:19 INFO - 'TERM': 'linux', 07:02:19 INFO - 'TMOUT': '86400', 07:02:19 INFO - 'USER': 'cltbld', 07:02:19 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461592915.310445-2046670663', 07:02:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:19 INFO - '_': '/tools/buildbot/bin/python'} 07:02:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:02:19 INFO - Running setup.py (path:/tmp/pip-FARP8V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:02:19 INFO - Running setup.py (path:/tmp/pip-6DBTus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:02:19 INFO - Running setup.py (path:/tmp/pip-RSYnv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:02:19 INFO - Running setup.py (path:/tmp/pip-ae86E2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:02:19 INFO - Running setup.py (path:/tmp/pip-DwfkAx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:02:19 INFO - Running setup.py (path:/tmp/pip-O6924Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:02:19 INFO - Running setup.py (path:/tmp/pip-zl5_Fp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:02:19 INFO - Running setup.py (path:/tmp/pip-XLH5GN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:02:19 INFO - Running setup.py (path:/tmp/pip-dvXRSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:02:19 INFO - Running setup.py (path:/tmp/pip-C1YX0_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:02:19 INFO - Running setup.py (path:/tmp/pip-zwGR0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:02:20 INFO - Running setup.py (path:/tmp/pip-SVdF0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:02:20 INFO - Running setup.py (path:/tmp/pip-SPDVee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:02:20 INFO - Running setup.py (path:/tmp/pip-dLyhjP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:02:20 INFO - Running setup.py (path:/tmp/pip-aYzYHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:02:20 INFO - Running setup.py (path:/tmp/pip-Ytt_tT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:02:20 INFO - Running setup.py (path:/tmp/pip-GnBP2t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:02:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:02:20 INFO - Running setup.py install for manifestparser 07:02:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:02:20 INFO - Running setup.py install for mozcrash 07:02:20 INFO - Running setup.py install for mozdebug 07:02:20 INFO - Running setup.py install for mozdevice 07:02:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:02:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:02:20 INFO - Running setup.py install for mozfile 07:02:20 INFO - Running setup.py install for mozhttpd 07:02:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:02:21 INFO - Running setup.py install for mozinfo 07:02:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:02:21 INFO - Running setup.py install for mozInstall 07:02:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:02:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:02:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:02:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:02:21 INFO - Running setup.py install for mozleak 07:02:21 INFO - Running setup.py install for mozlog 07:02:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:02:21 INFO - Running setup.py install for moznetwork 07:02:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:02:21 INFO - Running setup.py install for mozprocess 07:02:21 INFO - Running setup.py install for mozprofile 07:02:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:02:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:02:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:02:21 INFO - Running setup.py install for mozrunner 07:02:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:02:21 INFO - Running setup.py install for mozscreenshot 07:02:22 INFO - Running setup.py install for moztest 07:02:22 INFO - Running setup.py install for mozversion 07:02:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:02:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:02:22 INFO - Cleaning up... 07:02:22 INFO - Return code: 0 07:02:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:02: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')]} 07:02:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02: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')]} 07:02:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:22 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 0x7fe4df68af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13325a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c1410>, '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 0x13c2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13c27a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461592915.310445-2046670663', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:02:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:02:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:02:22 INFO - Using env: {'DISPLAY': ':0', 07:02:22 INFO - 'HOME': '/home/cltbld', 07:02:22 INFO - 'LANG': 'en_US.UTF-8', 07:02:22 INFO - 'LANGUAGE': 'en_US:en', 07:02:22 INFO - 'LOGNAME': 'cltbld', 07:02:22 INFO - 'MAIL': '/var/mail/cltbld', 07:02:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:22 INFO - 'MOZ_NO_REMOTE': '1', 07:02:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:22 INFO - 'NO_EM_RESTART': '1', 07:02:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:02:22 INFO - 'PWD': '/builds/slave/test', 07:02:22 INFO - 'SHELL': '/bin/bash', 07:02:22 INFO - 'SHLVL': '1', 07:02:22 INFO - 'TERM': 'linux', 07:02:22 INFO - 'TMOUT': '86400', 07:02:22 INFO - 'USER': 'cltbld', 07:02:22 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461592915.310445-2046670663', 07:02:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:22 INFO - '_': '/tools/buildbot/bin/python'} 07:02:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:02:22 INFO - Running setup.py (path:/tmp/pip-5QpqUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:02:22 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:02:22 INFO - Running setup.py (path:/tmp/pip-R4JECa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:02:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:02:22 INFO - Running setup.py (path:/tmp/pip-NX_IRJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:02:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:02:22 INFO - Running setup.py (path:/tmp/pip-WVHP_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:02:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:02:22 INFO - Running setup.py (path:/tmp/pip-GCbqeL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:02:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:02:22 INFO - Running setup.py (path:/tmp/pip-S3UWs8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:02:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:02:22 INFO - Running setup.py (path:/tmp/pip-61RYJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:02:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:02:22 INFO - Running setup.py (path:/tmp/pip-uUOOQO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:02:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:02:23 INFO - Running setup.py (path:/tmp/pip-kamf0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:02:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:02:23 INFO - Running setup.py (path:/tmp/pip-Aug737-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:02:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:02:23 INFO - Running setup.py (path:/tmp/pip-M_Drxd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:02:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:02:23 INFO - Running setup.py (path:/tmp/pip-8cvNqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:02:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:02:23 INFO - Running setup.py (path:/tmp/pip-tsC9nJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:02:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:02:23 INFO - Running setup.py (path:/tmp/pip-iluA7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:02:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:02:23 INFO - Running setup.py (path:/tmp/pip-NZgLiJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:02:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:02:23 INFO - Running setup.py (path:/tmp/pip-Q8rCNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:02:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:02:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:02:23 INFO - Running setup.py (path:/tmp/pip-WtyxFy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:02:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:02:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:02:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:02:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:02:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:02:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:02:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:02:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:02:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:02:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:25 INFO - Downloading blessings-1.6.tar.gz 07:02:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:02:25 INFO - Installing collected packages: blessings 07:02:25 INFO - Running setup.py install for blessings 07:02:25 INFO - Successfully installed blessings 07:02:25 INFO - Cleaning up... 07:02:25 INFO - Return code: 0 07:02:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:02:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:02:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:02:25 INFO - Reading from file tmpfile_stdout 07:02:25 INFO - Current package versions: 07:02:25 INFO - argparse == 1.2.1 07:02:25 INFO - blessings == 1.6 07:02:25 INFO - blobuploader == 1.2.4 07:02:25 INFO - docopt == 0.6.1 07:02:25 INFO - manifestparser == 1.1 07:02:25 INFO - mozInstall == 1.12 07:02:25 INFO - mozcrash == 0.17 07:02:25 INFO - mozdebug == 0.1 07:02:25 INFO - mozdevice == 0.48 07:02:25 INFO - mozfile == 1.2 07:02:25 INFO - mozhttpd == 0.7 07:02:25 INFO - mozinfo == 0.9 07:02:25 INFO - mozleak == 0.1 07:02:25 INFO - mozlog == 3.1 07:02:25 INFO - moznetwork == 0.27 07:02:25 INFO - mozprocess == 0.22 07:02:25 INFO - mozprofile == 0.28 07:02:25 INFO - mozrunner == 6.11 07:02:25 INFO - mozscreenshot == 0.1 07:02:25 INFO - mozsystemmonitor == 0.0 07:02:25 INFO - moztest == 0.7 07:02:25 INFO - mozversion == 1.4 07:02:25 INFO - psutil == 3.1.1 07:02:25 INFO - requests == 1.2.3 07:02:25 INFO - wsgiref == 0.1.2 07:02:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:02: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')]} 07:02:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02: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')]} 07:02:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:25 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 0x7fe4df68af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13325a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c1410>, '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 0x13c2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13c27a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461592915.310445-2046670663', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:02:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:02:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:02:25 INFO - Using env: {'DISPLAY': ':0', 07:02:25 INFO - 'HOME': '/home/cltbld', 07:02:25 INFO - 'LANG': 'en_US.UTF-8', 07:02:25 INFO - 'LANGUAGE': 'en_US:en', 07:02:25 INFO - 'LOGNAME': 'cltbld', 07:02:25 INFO - 'MAIL': '/var/mail/cltbld', 07:02:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:25 INFO - 'MOZ_NO_REMOTE': '1', 07:02:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:25 INFO - 'NO_EM_RESTART': '1', 07:02:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:02:25 INFO - 'PWD': '/builds/slave/test', 07:02:25 INFO - 'SHELL': '/bin/bash', 07:02:25 INFO - 'SHLVL': '1', 07:02:25 INFO - 'TERM': 'linux', 07:02:25 INFO - 'TMOUT': '86400', 07:02:25 INFO - 'USER': 'cltbld', 07:02:25 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461592915.310445-2046670663', 07:02:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:25 INFO - '_': '/tools/buildbot/bin/python'} 07:02:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:02:26 INFO - Cleaning up... 07:02:26 INFO - Return code: 0 07:02:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:02:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:02:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:02:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:26 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 0x7fe4df68af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13325a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c1410>, '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 0x13c2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13c27a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461592915.310445-2046670663', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:02:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:02:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:02:26 INFO - Using env: {'DISPLAY': ':0', 07:02:26 INFO - 'HOME': '/home/cltbld', 07:02:26 INFO - 'LANG': 'en_US.UTF-8', 07:02:26 INFO - 'LANGUAGE': 'en_US:en', 07:02:26 INFO - 'LOGNAME': 'cltbld', 07:02:26 INFO - 'MAIL': '/var/mail/cltbld', 07:02:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:26 INFO - 'MOZ_NO_REMOTE': '1', 07:02:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:26 INFO - 'NO_EM_RESTART': '1', 07:02:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:02:26 INFO - 'PWD': '/builds/slave/test', 07:02:26 INFO - 'SHELL': '/bin/bash', 07:02:26 INFO - 'SHLVL': '1', 07:02:26 INFO - 'TERM': 'linux', 07:02:26 INFO - 'TMOUT': '86400', 07:02:26 INFO - 'USER': 'cltbld', 07:02:26 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461592915.310445-2046670663', 07:02:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:26 INFO - '_': '/tools/buildbot/bin/python'} 07:02:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:26 INFO - Downloading/unpacking jsonschema 07:02:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:02:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:02:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:02:28 INFO - Downloading/unpacking functools32 (from jsonschema) 07:02:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:02:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:02:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:28 INFO - Downloading functools32-3.2.3-2.tar.gz 07:02:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:02:28 INFO - warning: no files found matching '*.txt' 07:02:28 INFO - no previously-included directories found matching 'build' 07:02:28 INFO - no previously-included directories found matching 'dist' 07:02:28 INFO - no previously-included directories found matching '.git*' 07:02:28 INFO - Installing collected packages: jsonschema, functools32 07:02:28 INFO - Running setup.py install for functools32 07:02:28 INFO - warning: no files found matching '*.txt' 07:02:28 INFO - no previously-included directories found matching 'build' 07:02:28 INFO - no previously-included directories found matching 'dist' 07:02:28 INFO - no previously-included directories found matching '.git*' 07:02:28 INFO - Successfully installed jsonschema functools32 07:02:28 INFO - Cleaning up... 07:02:28 INFO - Return code: 0 07:02:28 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:02: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')]} 07:02:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02: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')]} 07:02:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:28 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 0x7fe4df68af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12678a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13325a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c1410>, '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 0x13c2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13c27a0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1461592915.310445-2046670663', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:02:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 07:02:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:02:28 INFO - Using env: {'DISPLAY': ':0', 07:02:28 INFO - 'HOME': '/home/cltbld', 07:02:28 INFO - 'LANG': 'en_US.UTF-8', 07:02:28 INFO - 'LANGUAGE': 'en_US:en', 07:02:28 INFO - 'LOGNAME': 'cltbld', 07:02:28 INFO - 'MAIL': '/var/mail/cltbld', 07:02:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:28 INFO - 'MOZ_NO_REMOTE': '1', 07:02:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:28 INFO - 'NO_EM_RESTART': '1', 07:02:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:02:28 INFO - 'PWD': '/builds/slave/test', 07:02:28 INFO - 'SHELL': '/bin/bash', 07:02:28 INFO - 'SHLVL': '1', 07:02:28 INFO - 'TERM': 'linux', 07:02:28 INFO - 'TMOUT': '86400', 07:02:28 INFO - 'USER': 'cltbld', 07:02:28 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461592915.310445-2046670663', 07:02:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:28 INFO - '_': '/tools/buildbot/bin/python'} 07:02:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:29 INFO - Downloading/unpacking flake8 07:02:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:02:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:02:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:02:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:02: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 07:02: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 07:02: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 07:02: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 07:02: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 07:02: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 07:02:31 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:02:31 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:02:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:02:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:02:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:31 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:02:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:02:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:02:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:02:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:02:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:02:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:02:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:02:31 INFO - no previously-included directories found matching 'docs/_build' 07:02:31 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:02:31 INFO - Running setup.py install for pep8 07:02:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:02:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:02:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:02:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:02:31 INFO - no previously-included directories found matching 'docs/_build' 07:02:31 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:02:31 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:02:31 INFO - Cleaning up... 07:02:31 INFO - Return code: 0 07:02:31 INFO - Running post-action listener: _resource_record_post_action 07:02:31 INFO - Running post-action listener: _start_resource_monitoring 07:02:31 INFO - Starting resource monitoring. 07:02:31 INFO - ##### 07:02:31 INFO - ##### Running install step. 07:02:31 INFO - ##### 07:02:31 INFO - Running pre-action listener: _resource_record_pre_action 07:02:31 INFO - Running main action method: install 07:02:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:02:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:02:32 INFO - Reading from file tmpfile_stdout 07:02:32 INFO - Detecting whether we're running mozinstall >=1.0... 07:02:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:02:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:02:32 INFO - Reading from file tmpfile_stdout 07:02:32 INFO - Output received: 07:02:32 INFO - Usage: mozinstall [options] installer 07:02:32 INFO - Options: 07:02:32 INFO - -h, --help show this help message and exit 07:02:32 INFO - -d DEST, --destination=DEST 07:02:32 INFO - Directory to install application into. [default: 07:02:32 INFO - "/builds/slave/test"] 07:02:32 INFO - --app=APP Application being installed. [default: firefox] 07:02:32 INFO - mkdir: /builds/slave/test/build/application 07:02:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:02:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:02:48 INFO - Reading from file tmpfile_stdout 07:02:48 INFO - Output received: 07:02:48 INFO - /builds/slave/test/build/application/firefox/firefox 07:02:48 INFO - Running post-action listener: _resource_record_post_action 07:02:48 INFO - ##### 07:02:48 INFO - ##### Running run-tests step. 07:02:48 INFO - ##### 07:02:48 INFO - Running pre-action listener: _resource_record_pre_action 07:02:48 INFO - Running main action method: run_tests 07:02:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:02:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:02:48 INFO - Python 2.7.3 07:02:48 INFO - Return code: 0 07:02:48 INFO - grabbing minidump binary from tooltool 07:02:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:02:48 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 0x13c1410>, '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 0x13c2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13c27a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:02:48 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:02:48 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:02:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:02:48 INFO - Return code: 0 07:02:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:02:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:02:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:02:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:02:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:02:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:02:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:02:48 INFO - Return code: 0 07:02:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OMTqYplySRKqVp28AOG53Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:02:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OMTqYplySRKqVp28AOG53Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:02:48 INFO - Using env: {'DISPLAY': ':0', 07:02:48 INFO - 'HOME': '/home/cltbld', 07:02:48 INFO - 'LANG': 'en_US.UTF-8', 07:02:48 INFO - 'LANGUAGE': 'en_US:en', 07:02:48 INFO - 'LOGNAME': 'cltbld', 07:02:48 INFO - 'MAIL': '/var/mail/cltbld', 07:02:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:02:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:02:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:48 INFO - 'MOZ_NO_REMOTE': '1', 07:02:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:02:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:48 INFO - 'NO_EM_RESTART': '1', 07:02:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:02:49 INFO - 'PWD': '/builds/slave/test', 07:02:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:02:49 INFO - 'SHELL': '/bin/bash', 07:02:49 INFO - 'SHLVL': '1', 07:02:49 INFO - 'TERM': 'linux', 07:02:49 INFO - 'TMOUT': '86400', 07:02:49 INFO - 'USER': 'cltbld', 07:02:49 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1461592915.310445-2046670663', 07:02:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:49 INFO - '_': '/tools/buildbot/bin/python'} 07:02:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OMTqYplySRKqVp28AOG53Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:02:49 INFO - mozversion application_buildid: 20160425053553 07:02:49 INFO - mozversion application_changeset: 0f07f975526f3abda2f997bbb2feb0a25f771227 07:02:49 INFO - mozversion application_display_name: Nightly 07:02:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:02:49 INFO - mozversion application_name: Firefox 07:02:49 INFO - mozversion application_remotingname: firefox 07:02:49 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:02:49 INFO - mozversion application_vendor: Mozilla 07:02:49 INFO - mozversion application_version: 48.0a1 07:02:49 INFO - mozversion platform_buildid: 20160425053553 07:02:49 INFO - mozversion platform_changeset: 0f07f975526f3abda2f997bbb2feb0a25f771227 07:02:49 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:02:49 INFO - mozversion platform_version: 48.0a1 07:02:49 INFO - using testdate: 1461592969 07:02:49 INFO - actual date: 1461592969 07:02:49 INFO - starting webserver on 'localhost:51862' 07:02:49 INFO - SUITE-START | Running 2 tests 07:02:49 INFO - TEST-START | dromaeo_css 07:02:49 INFO - operating with platform_type : linux_ 07:02:49 INFO - Initialising browser for dromaeo_css test... 07:02:49 INFO - TEST-INFO | started process 5888 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEWkzWt/profile http://localhost:51862/getInfo.html) 07:02:53 INFO - PROCESS | 5888 | 07:02:53 INFO - PROCESS | 5888 | (process:5957): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:02:54 INFO - PROCESS | 5888 | __metrics Screen width/height:1600/1200 07:02:54 INFO - PROCESS | 5888 | colorDepth:24 07:02:54 INFO - PROCESS | 5888 | Browser inner width/height: 1024/697 07:02:54 INFO - PROCESS | 5888 | __metrics 07:02:54 ERROR - PROCESS | 5888 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 07:02:55 INFO - TEST-INFO | 5888: exit 0 07:02:55 INFO - Browser initialized. 07:02:55 INFO - Running cycle 1/1 for dromaeo_css test... 07:02:55 INFO - TEST-INFO | started process 6009 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEWkzWt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:02:57 INFO - PROCESS | 6009 | 07:02:57 INFO - PROCESS | 6009 | (process:6069): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:03:07 INFO - PROCESS | 6009 | RSS: Main: 166060032 07:03:07 INFO - PROCESS | 6009 | 07:03:57 INFO - PROCESS | 6009 | 1461593037339 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:06:08 INFO - PROCESS | 6009 | Cycle 1(1): loaded http://localhost:51862/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51862/tests/dromaeo/cssquery-ext.html) 07:06:09 INFO - PROCESS | 6009 | RSS: Main: 169144320 07:06:09 INFO - PROCESS | 6009 | 07:09:11 INFO - PROCESS | 6009 | Cycle 1(1): loaded http://localhost:51862/tests/dromaeo/cssquery-ext.html (next: http://localhost:51862/tests/dromaeo/cssquery-jquery.html) 07:09:12 INFO - PROCESS | 6009 | RSS: Main: 167845888 07:09:12 INFO - PROCESS | 6009 | 07:12:14 INFO - PROCESS | 6009 | Cycle 1(1): loaded http://localhost:51862/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51862/tests/dromaeo/cssquery-mootools.html) 07:12:14 INFO - PROCESS | 6009 | RSS: Main: 168161280 07:12:14 INFO - PROCESS | 6009 | 07:15:16 INFO - PROCESS | 6009 | Cycle 1(1): loaded http://localhost:51862/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51862/tests/dromaeo/cssquery-prototype.html) 07:15:17 INFO - PROCESS | 6009 | RSS: Main: 166170624 07:15:17 INFO - PROCESS | 6009 | 07:18:20 INFO - PROCESS | 6009 | Cycle 1(1): loaded http://localhost:51862/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51862/tests/dromaeo/cssquery-yui.html) 07:18:20 INFO - PROCESS | 6009 | RSS: Main: 167153664 07:18:20 INFO - PROCESS | 6009 | 07:21:23 INFO - PROCESS | 6009 | Cycle 1(1): loaded http://localhost:51862/tests/dromaeo/cssquery-yui.html (next: http://localhost:51862/tests/dromaeo/cssquery-dojo.html) 07:21:23 INFO - PROCESS | 6009 | RSS: Main: 169713664 07:21:23 INFO - PROCESS | 6009 | 07:21:23 INFO - PROCESS | 6009 | __start_tp_report 07:21:23 INFO - PROCESS | 6009 | _x_x_mozilla_page_load 07:21:23 INFO - PROCESS | 6009 | _x_x_mozilla_page_load_details 07:21:23 INFO - PROCESS | 6009 | |i|pagename|runs| 07:21:23 INFO - PROCESS | 6009 | |0;dojo.html;2624.2127361791463;2666.679998400192;2709.078913169522;2719.768819650331;2720.9047683331087;4753.833615823442;4775.474697783246;4787.13831510328;4805.295794867708;4838.104950584145;4706.435227772672;4793.880152996177;4843.443004054535;4844.128056949757;4915.950840491594;4395.077033822901;4426.358178064179;4455.84404545841;4474.440694913136;4520.886977825548;642.187824275483;4297.570242975693;4335.891602709926;4346.152500262434;4383.211022016036;4443.911121777546;4451.065276291983;4451.755153466558;4473.731576105444;4504.459464864204;4459.665525085632;4460.598546130831;4467.955320446787;4473.127740090684;4499.775011249457;4222.9577704223175;4359.367891655692;4400.691951563392;4425.734455932622;4442.62237709795;4638.350630911675;4695.976520117411;4704.364910737041;4708.152532544141;4729.810807567727;4929.876753081166;5136.152534831748;5151.098557752378;5167.844964651066;5185.740712964374;5109.693418394908;5127.564157046656;5167.863070124567;5184.274201611777;5200.115980283361;4742.0515896820425;4785.760711964457;4791.6645834791925;4809.807607695688;4834.226523756182;5115.71863547501;5244.265802787613;5266.104762190437;5272.489550109937;5272.9736351318;5095.821646242363;5107.131787596118;5109.335786347751;5111.361079865017;5159.974200128975;5183.2743415921805;5193.922091168635;5194.402643696023;5194.506521880416;5253.080710875582;4826.613870890391;5037.269595908573;5102.183650615883;5137.049645815536;5151.922721159186;5074.695518268915;5101.05630458359;5110.182370820651;5113.821016264413;5134.332536770196;4335.436393268855;4335.523092459827;4344.587264209895;4367.71609845359;4375.256206444912;3685.8894233173046;3736.75711078779;3786.848526058982;3798.3732684107367;3860.0542866997766;4355.673324500612;4455.1980643484485;4469.910601787946;4474.463064432224;4488.304312831517;5194.948050519522;5211.114110601206;5212.113940630102;5212.765425555859;5258.684478931276;4385.079133382025;4456.732596044183;4456.997175635521;4518.796654150571;4595.425571803525;4524.524924882906;4549.545045495424;4605.078984203173;4675.158471475099;4697.248440249612;4860.659753817199;4896.045271172087;4907.975460122677;4909.975450122726;4950.702957822542;5216.40011398694;5217.556507696737;5219.2953951216095;5219.76511057011;5222.503862133091;4729.55069268419;4831.4202295724735;4882.6826256293225;4908.969116485578;4935.851924442272;5074.82238121664;5077.619178561548;5087;5093.337866077386;5145.691258524501;4962.578180854523;5169.379674439091;5177.068127737043;5188.351456067991;5189.844304670866;4945.505449455026;4983.476734942778;5003.874903127451;5009.298698182331;5012.649114561946;4973.477784832685;4980.203167493329;5009.373828271466;5037.546620804145;5082.949170508247;4768.57082862544;4868.659193856396;4934.210526315772;4949.158643030765;4993.625478089085;4990.775415106256;5053.7473126344275;5055.191169412877;5063.594912407072;5115.590752739847;4940.555350018516;4960.851174464772;4963.553280204799;4965.0318187953;5027.170516864677 07:21:23 INFO - PROCESS | 6009 | |1;ext.html;578.9421057894211;588.3028611095851;610.5909040942568;618.3229363846592;650.3366566102573;34018.48972265418;35179.64820351796;35536;35575.46636800447;35583.46624800627;37530;38177.809110954404;38234.80882595583;38299.80850095746;38307.23385532288;7692.9230707692905;7841.6079196040255;7845.2547008034435;7871.763847084597;7878.6848526059175;7621.885671714928;7741.187175346592;7770.494917830351;7899.28906398424;7985.281324680806;7957.244061814147;8016.158303378149;8019.318357939582;8028.879566806502;8043.195680431969;7927.960360198191;7957.124716281204;7973.880391794128;7981.48120372174;8008.719694810712;7838.686452541891;7964.920350796476;7969.163237859999;7977.48146370484;8036.156203598596;38000.80999595012;38415.8079209605;38423.80788096042;38659.8067009666;38696;2826.844523551204;2896.6234389529436;2902.2454161917844;2926.9853650731825;2936.9412611747857;29239.41521169586;29367.2658183545;29481.705182948324;29824.254393640116;29922.55116173259;3428.468587368962;3451.516787649731;3468.1156305142026;3491.6508349165133;3491.8777842775635;176346;176422.65041447105;176608;177390;177423;48058.519414806105;48095.278570821465;48131.27803082956;48242.27636585454;48337.27494087591;52153.47846521562;52366.47633523692;52410.73794631002;52490.21264681033;56251.71874140685;13270.270135142468;13429.865701343057;13463;13473.191608503324;13496.730065398637;10555.577776888838;10582.417967011888;10600.098991585648;10612.840807387895;10675.519601617945;18075.186616602285;18209.63580728378;18220.635587288445;18283.360082397052;18397.264109435473;6893.172819261721;7048.577085374894;7125.50121491501;7307.525010874276;7353.595552244571;780.8945792318078;790.774629230678;859.1923591823665;873.1661263493348;960.2462067277154;28165.43669126606;28390.574141387897;28687.56968645472;28855.134345969655;28915.42169156605;971.5385192033727;990.3513198854762;1006.8873894346788;1026.2918586175665;1054.8365003424328;15330.770038449433;15366.231688415535;15451.150186739613;15630.06219626826;15736.68526629461;328849;338097;338389;339409;339821;48242;48717.75641121772;49301.50698492969;49493.257601136014;49563.50436495661;1178.7701398227264;1214.860291066521;1227.312704885267;1231.1874163052341;1260.7478504298992;26822.463550728487;27455.45089098247;27920.44159116847;28009.859950700116;28138.577921330787;42429;42468.78765606152;42568.78715606402;42700.78649606856;42716.35925461183;289663;290507;291931;292565;293752;25366.873165634053;25602.61596076023;25901;26033.219003429927;26269.34326641849;42022.36966445567;42458.57541424546;42583.14833703371;42686.78656606697;43399.56600434081;35245.64754352424;35814.64185358113;35868.28263434769;36059.81970090238;36952.44571331486;35143.64856351506;35305.82347088351;35331.64668353284;35749.821250893576;35904.46143307905;31590.210244743146;33102.33795324128;33147.66852331446;35854.82072589621;35951.64048359483;28198.295042624097;29855.701442985293;31219.687803121677;31733.206669832514;31788.205294867814;24679.136230231856;24830.130945416822;24855.254342369757;24899.62650560279;24927.626085608368 07:21:23 INFO - PROCESS | 6009 | |2;jquery.html;383.5414989914646;383.9923201535969;387.96120387961207;393.201800345299;398.9182217645383;12825.422855971481;15201.923990380046;15608.765868511953;17011.234494447763;17288.74066888996;15286.923565382158;15521.146336951491;15882.126483043428;16474.258658360373;16484.175791210422;5141;5179.8446046618565;5214.296070030554;5321.547668448186;5356.812511562096;5272.525472707455;5275.49882761139;5288.60335474839;5304.575633949294;5311.760970756325;5026.045051440233;5262.079136151177;5266.8419947401635;5271.499207575274;5278.577713782888;5228.189630607224;5250.238715386286;5280.551153151987;5286.392064912527;5292.550133238679;4492.68551201416;4678.041001594699;4708.952910470885;4727.64542659302;4751.002289519205;19857.106430210675;20098.497537561532;20127.899360503252;20181.495462613406;20361.389158325273;1834.5046837353839;1850.9722354164699;1896.924123035077;1914.5979344337707;2033.0647901964967;12523.311217883012;13408.061435699505;13510.797338039938;13621.182729036289;13711.108777929403;1791.2208189437636;1802.8647851411197;1810.1944634637591;1813.38344962712;1822.8086050964723;67838;68297.65851170712;68474;68784.3121568783;69158.3084169157;9282.628694852265;9305.581248843819;9723.61105555784;9906.950465247772;9922.305438619227;11836.763264734656;12771.808422873664;13386.19682819034;13413.262270575213;13492.257925813978;7106.502544821917;7177.246389129066;7225.530340527849;7253.601051942193;7342.853142937218;6848.3494068063455;6867.244603093655;6959.338862808025;7064.32888875556;7067.363937245673;6010.939890601126;6213.875722485525;6213.937860621336;6232.8130156095385;6260.7495700171485;1810.9094545272683;1889.0743535667425;1889.3859495663964;1891.328578354692;1905.6855618823017;836.2097817562467;872.7905302727299;923.2475532441039;927.4388994658269;947.7014740356904;15207.695846083016;16189.433369832235;16585.668286634198;16974.660506789794;17062.061586612606;868.70898249086;897.9865302020474;901.1394118616705;903.9096090390908;966.2897770138942;9055;9499.43003419797;9699.418034917928;9737.123658870736;10017.649382271586;357694;362429;363526;365395;370790;81125.18874811176;81710;82301.58849205716;84048;84333.57833210795;959.1703176752059;968.801395713877;977.2524019125375;997.1275134257525;997.8802543694803;15146.621334466727;15149.545513634608;15292.158931258888;15307.46423875159;15610.297536611108;29124.3635930564;30421.109994550483;35059;35219.47170792492;35898;42319.1536169281;43001.78499107484;43729.56270437255;46163;48765.268520972924;7239.203687594466;7287.380572651172;7331.890021649573;7370.6683199255085;7596.81007974805;9575.377600455948;11002.22984391117;11223.4388280584;11227.49476273586;11318.717032074264;9156.496392698466;9302.860457093284;9368.39105458143;9395.765105872408;9640.891297500877;9511.66709165176;9522.85715714251;9684.370515916444;9892.159166470643;9992.750181245236;9426.387284826464;9445.244380449685;9467.053294670477;9777.608895644094;9883.159931405911;7253.673584688596;7259.963700181465;7357;7434.070741157356;7458.366038886756;8840.381173317806;9191.310651701282;9726.562304696165;10138.89861101409;10212.183025358103 07:21:23 INFO - PROCESS | 6009 | |3;mootools.html;1447.1678784698797;1483.4956114920928;1635.9018458892467;1761.1898526677728;1799.199356286453;6691.26396096429;7426.554406735593;7492.775216743493;7763.689452421911;7767.495112817663;7314.487985840993;7353.0441042664515;7372.7050917963215;7411.221821708724;7427.25727427257;2222.822174226062;2241.5068684889297;2263.0495192019393;2265.6035193841094;2274.2722328854775;2183.3449965010514;2188.070070220158;2222.9888850555726;2224.5884511365366;2233.2741858895843;2225.8441909066373;2227.0535022615404;2252.4368907773055;2261.185973049709;2261.6268315727884;2206.569718904806;2207.227470385368;2212.623853944833;2216.4791274050745;2217.6562632792024;2198.933517244135;2200.548887478063;2203.0747086223823;2208.1719355241785;2215;7737.845243095163;7768.922310776877;7772.961135194344;7775.300222979959;7776.611169441505;4604.355390245369;4720.787564559603;4755.286706993978;4760.166970780134;4800.1839687252905;2747.4367754610457;2925.3856690095104;2954.4534261161753;2961.318896653782;2969.5248760198265;907.1472815553359;913.3423934766957;922.6355589542161;929.1962452478557;931.8788557487551;10397.428141452217;10412.42731649759;10421.166306695446;10439.42583157926;10447.79104417915;4192.329227323614;4308.159908817813;4320.071184695305;4363.585459381354;4424.756638384855;8825.69110081144;8864.335174861782;8865.601047952858;8893.644254229888;8897.243734282529;4656.4412270527755;4701.200795864711;4752.1683705351425;4757.024809913959;4758.119747846659;3653.725970552219;4182.811773470201;4228.175505776406;4292.914141717149;4322.740635561813;3602.2615363850346;3653.214558869856;3740.7942563159286;3754.887353379403;3757.812109394519;1186.32379543661;1223.3760782001066;1231.7536492701495;1241.919275247106;1243.4155946705034;613.5183880653666;653.3270731146831;754.9320561149523;813.6460639621783;829.4649950781712;4826.61387089032;4932.28481870134;4933.333999910038;5052.722100284446;5204.4014938281825;829.7261903571807;878.0867897386646;882.148726478951;889.5285498685707;909.8726178335038;3399.6260411354733;3449.534312867781;3451.2062225688233;3512.5609298837644;3526.647335266453;9464.100910413637;9676.612935482643;9715.562799674031;9740.951295243478;9827.312088153903;9651.276154288456;9675.854862177073;9676.95161524202;9741.9025809741;9746.415215086976;7210.206877243499;7369.447291453055;7418.851622967511;7491.8501629967095;7494.999999999891;4785.306130610972;4940.283658869515;4958.628102892226;4988.102141614544;5034.949650503595;8918.286537077149;8986.101389860962;9008.63965441375;9022;9066.09339066088;8878.911210887809;9240.399374040666;9242.491662958602;9242.907570924204;9251.722448326562;5659;6114.38856114385;6400.103985442135;6471.741130354922;6576.736930522726;7224.494285399972;7245.529040612343;7260.2739726026975;7282.745103921337;7343.559386436831;6298.1812364392335;6465.709043092978;6524.641144737085;6689.130413046468;6691.063251144941;6469.644169570719;6560.44236239925;6601;6656.0348749430095;6695.363940425652;5781.046127388934;5898.262717160355;5916.704164791657;5937.7921772737745;5949.672767997802;4379.321205213197;4476.888077797951;4500.437445319335;4532.66005049616;4537.909241815079;4474.306482495218;4489.483709373464;4536.88657783558;4554.20301447252;4585.518520555293 07:21:23 INFO - PROCESS | 6009 | |4;prototype.html;309.78160396920174;314.5847481324651;315.80735751191753;318.92186414328484;321.15696297219796;4940.6047516198705;5049.747512624373;5068.1890897456415;5095.923561146581;5102.719350435725;4937.679050861691;4940.851774446773;4942.654014218997;4979.601631869451;4983.651144419883;3707.110293529554;3839.8656047038357;3924.7645141291473;3930;3931.842726290945;3930.921381572367;3935.3703407454814;3957.6148348078086;3968.6825053995753;3969;3936.0946982194114;3943.6450719435247;3949.012746813297;3957.0915377197734;3958.584348643394;3872.6901847852105;3918.0792513759243;3936.8622098226424;3961.4652021977095;3964.623360780721;3476.6523347665284;3483.477478378238;3505.3690335739557;3508.245727168671;3514.595821480537;4745.786439610226;4799.18413869643;4806.663533552653;4809.759512024385;4815.277708343741;4354.325079612665;4491.25894227452;4508.368828364031;4516.803047192497;4535.433070866142;5178.17149256121;5223.73881305937;5235.58115350771;5269.235960785664;5274.498922602346;3776.7167462440425;3784.924301513954;3798.5812768508563;3799.22115966229;3836.731428799957;5385.380681221632;5461.563074953994;5495.587830912657;5502.9174562381195;5526.751296191681;3894.90262743428;3904.2581909437117;3912.689249101526;3924.6664033556895;3927.273454410943;3956.287868183697;3963.8612648557164;3970.622790834866;3978.562358140602;3981.761094334291;4455.287154055336;4479.104179164115;4485.686001979895;4493.505714371417;4496.617787488035;5110.131277682803;5194.636375453758;5200.297959775382;5200.843974680765;5210.505002024802;1432.6275168456277;1443.0836418874092;1452.7893455449112;1454.163855782929;1454.8908831837655;917.8384903552172;963.1668606655193;998.14159822554;1000.474750755859;1005.190821388789;4590.150822097922;4703.85888423341;4725.669203155746;4736;4738.691985020962;5463.426340234298;5470.288862447856;5489.149181876815;5491.780328786884;5522.144067669517;4562.977185114053;4634.046478588414;4695.460022097434;4700.694454860423;4711.717296962193;3112.9533057004164;3124.7968882022597;3126.796758210709;3133.8433078345993;3155.0534839548045;5415.1335786274;5460.945390546044;5477.698726570077;5479.397266300703;5499.202615620713;5755.568332375088;5915.881682366328;5946.940530594725;6004.909926351108;6009.609375390585;5425.972870135624;5445.809396671098;5462.317210348707;5478.315210598676;5495.587830912617;5640.971795140998;5817.272840894888;5822.7670893163795;5830.62100963436;5856.150858125633;5701.771929122954;5715.714214289352;5725.770969161187;5742.942570574241;5749.482546570662;5444.482774136451;5466.234727138124;5495.450454954473;5502.862428439161;5504.4770746778995;3988.481497405319;4011.939820902747;4055.858044968412;4061.3095773717946;4065.9796701016307;5742.138679198154;5816.883662326814;5828.125781132864;5831.475167234969;5849;5589.217509548585;5604.2154098425435;5640.54875609942;5643.238162847963;5655.886882262414;5427.3215848019;5599.440055994368;5635.126555383922;5643.238162847963;5659.717014149359;5526.198701188225;5544.667319960815;5547.778088876561;5571;5574.442555744556;5007.424146223231;5028.773705183203;5251.159814429673;5259.948620038264;5285.735713214401;5147.6911385317;5160.509751573594;5164.586833053271;5166.8966620668125;5169.224616307584 07:21:23 INFO - PROCESS | 6009 | |5;yui.html;643.5012865029602;714.4248879651878;719.7480881691408;787.4645241235961;800.2077942836594;10888.40113793742;10895.400752958574;10958.12335013199;10982.682078150634;11973.880261197386;11722.472488738005;11998.520059197643;12117.151799374047;12135;12220.266783992967;786.5202226641744;808.1554775259867;808.4421748993176;808.486611002015;809.352517985612;636.0903907412398;788.1251810490351;804.1757198871145;814.0150417994234;821.9589020548979;848.2365870716374;850.4472093139447;857.6569372251118;857.8412993596173;858.2018722587991;847.2290215903498;852.7782776478099;852.7868032991752;852.8336974290016;853.8932633420823;620.6555361774214;626.3517259636254;626.8464226264595;627.4697880291146;628.3936001758279;11897.583584574499;11901.404929753478;11916.761664766744;11925.880741192565;11942.223755455954;12156.149069565046;12260.570880019157;12485.93757031218;12599.811002834966;12640.304783236918;9485.498609455673;9598.42409455435;9620.90379096214;9758.072983066597;9845;3283.063395884462;3314.6022477302636;3315.5689760331243;3329.88345407912;3407.522946787452;43006.56993430057;43106.13787724228;43120.78439607782;43311;44310.11379772386;9420.858687119699;9667.516624168904;9761.267904907161;10200.132988695896;10233.9488302558;16847.410340638264;16905.070221137954;16976.74534881978;17075.658486830194;17091.914540427468;6378.425941665272;6655.933440665628;6665.866682666319;6782.948642960349;6806.863862722717;3531.94702079469;3551.9644803551632;3557.786532807988;3577;3615.1504396466808;2766.5988431677292;2816.2396153038567;2817.492851286788;2820.858957052139;2824.943501130007;487.6318379623362;502.00352300683113;502.90444815484943;504.7123139810273;509.1573445946964;557.7183522321202;570.5806232419169;571.3087164530881;595.7438301530384;610.8930937085992;7294.379977701955;7406.852162788856;7417.888731669029;7535.171131175566;7624;481.4920259126585;527.5542166868989;555.7221389305347;569.9544036477072;570.4409678515078;3667.8166091695307;3764.8682296119505;3794.9810250948567;3809.2191100824266;3887.4168874669026;51148;56049;56383;56392;56444.43555564474;41907;44692.77653611711;45273.77363113163;47596.5240347599;48623;43331.78334108373;44212;44354;44844.55155448469;44968;7547.660355283915;7754.806129846799;7796.220377962159;7893.605319733875;7955.164707705839;29495.26261843471;29507.704922951354;29711.85144074266;30038;30213.395732085675;36598.817005915866;38365.424518632804;38859.805700971316;38946.80526597349;39752.60247397489;10002.29983901149;10038.19694424459;10129.392236465836;10154.644587439405;10206.336588121749;10806.297590656583;10833.404162771123;10933.781324373627;11469.81692849465;11757.059435244988;9814;10199.28604997643;10287.84568231462;10509.474526273809;10692.786144277226;10541.4729263535;10598.470076496298;10681.946590266998;10789.62236321725;10840.620578280037;9547.140757331874;9780.706578802647;9850.359726617748;10100.343477673927;10440.112590429899;8953.104689531256;9008.234300084305;9034.593443295198;9095.090490950852;9249.263617469867;7698.461107722405;7987.440879138637;8050.597470126588;8097.554634495159;8212.548309842778 07:21:23 INFO - PROCESS | 6009 | __end_tp_report 07:21:23 INFO - PROCESS | 6009 | __start_cc_report 07:21:23 INFO - PROCESS | 6009 | _x_x_mozilla_cycle_collect,379 07:21:23 INFO - PROCESS | 6009 | __end_cc_report 07:21:23 INFO - PROCESS | 6009 | __startTimestamp1461594083507__endTimestamp 07:21:23 INFO - PROCESS | 6009 | 07:21:23 INFO - PROCESS | 6009 | ------- Summary: start ------- 07:21:23 INFO - PROCESS | 6009 | Number of tests: 6 07:21:23 INFO - PROCESS | 6009 | 07:21:23 INFO - PROCESS | 6009 | [#0] dojo.html Cycles:165 Average:4732.55 Median:4908.97 stddev:596.37 (12.1%) stddev-sans-first:574.81 07:21:23 INFO - PROCESS | 6009 | Values: 2624.2 2666.7 2709.1 2719.8 2720.9 4753.8 4775.5 4787.1 4805.3 4838.1 4706.4 4793.9 4843.4 4844.1 4916.0 4395.1 4426.4 4455.8 4474.4 4520.9 642.2 4297.6 4335.9 4346.2 4383.2 4443.9 4451.1 4451.8 4473.7 4504.5 4459.7 4460.6 4468.0 4473.1 4499.8 4223.0 4359.4 4400.7 4425.7 4442.6 4638.4 4696.0 4704.4 4708.2 4729.8 4929.9 5136.2 5151.1 5167.8 5185.7 5109.7 5127.6 5167.9 5184.3 5200.1 4742.1 4785.8 4791.7 4809.8 4834.2 5115.7 5244.3 5266.1 5272.5 5273.0 5095.8 5107.1 5109.3 5111.4 5160.0 5183.3 5193.9 5194.4 5194.5 5253.1 4826.6 5037.3 5102.2 5137.0 5151.9 5074.7 5101.1 5110.2 5113.8 5134.3 4335.4 4335.5 4344.6 4367.7 4375.3 3685.9 3736.8 3786.8 3798.4 3860.1 4355.7 4455.2 4469.9 4474.5 4488.3 5194.9 5211.1 5212.1 5212.8 5258.7 4385.1 4456.7 4457.0 4518.8 4595.4 4524.5 4549.5 4605.1 4675.2 4697.2 4860.7 4896.0 4908.0 4910.0 4950.7 5216.4 5217.6 5219.3 5219.8 5222.5 4729.6 4831.4 4882.7 4909.0 4935.9 5074.8 5077.6 5087.0 5093.3 5145.7 4962.6 5169.4 5177.1 5188.4 5189.8 4945.5 4983.5 5003.9 5009.3 5012.6 4973.5 4980.2 5009.4 5037.5 5082.9 4768.6 4868.7 4934.2 4949.2 4993.6 4990.8 5053.7 5055.2 5063.6 5115.6 4940.6 4960.9 4963.6 4965.0 5027.2 07:21:23 INFO - PROCESS | 6009 | 07:21:23 INFO - PROCESS | 6009 | [#1] ext.html Cycles:180 Average:42771.18 Median:35318.74 stddev:72662.19 (205.7%) stddev-sans-first:72796.97 07:21:23 INFO - PROCESS | 6009 | Values: 578.9 588.3 610.6 618.3 650.3 34018.5 35179.6 35536.0 35575.5 35583.5 37530.0 38177.8 38234.8 38299.8 38307.2 7692.9 7841.6 7845.3 7871.8 7878.7 7621.9 7741.2 7770.5 7899.3 7985.3 7957.2 8016.2 8019.3 8028.9 8043.2 7928.0 7957.1 7973.9 7981.5 8008.7 7838.7 7964.9 7969.2 7977.5 8036.2 38000.8 38415.8 38423.8 38659.8 38696.0 2826.8 2896.6 2902.2 2927.0 2936.9 29239.4 29367.3 29481.7 29824.3 29922.6 3428.5 3451.5 3468.1 3491.7 3491.9 176346.0 176422.7 176608.0 177390.0 177423.0 48058.5 48095.3 48131.3 48242.3 48337.3 52153.5 52366.5 52410.7 52490.2 56251.7 13270.3 13429.9 13463.0 13473.2 13496.7 10555.6 10582.4 10600.1 10612.8 10675.5 18075.2 18209.6 18220.6 18283.4 18397.3 6893.2 7048.6 7125.5 7307.5 7353.6 780.9 790.8 859.2 873.2 960.2 28165.4 28390.6 28687.6 28855.1 28915.4 971.5 990.4 1006.9 1026.3 1054.8 15330.8 15366.2 15451.2 15630.1 15736.7 328849.0 338097.0 338389.0 339409.0 339821.0 48242.0 48717.8 49301.5 49493.3 49563.5 1178.8 1214.9 1227.3 1231.2 1260.7 26822.5 27455.5 27920.4 28009.9 28138.6 42429.0 42468.8 42568.8 42700.8 42716.4 289663.0 290507.0 291931.0 292565.0 293752.0 25366.9 25602.6 25901.0 26033.2 26269.3 42022.4 42458.6 42583.1 42686.8 43399.6 35245.6 35814.6 35868.3 36059.8 36952.4 35143.6 35305.8 35331.6 35749.8 35904.5 31590.2 33102.3 33147.7 35854.8 35951.6 28198.3 29855.7 31219.7 31733.2 31788.2 24679.1 24830.1 24855.3 24899.6 24927.6 07:21:23 INFO - PROCESS | 6009 | 07:21:23 INFO - PROCESS | 6009 | [#2] jquery.html Cycles:180 Average:23354.68 Median:5272.01 stddev:60336.03 (1144.5%) stddev-sans-first:60480.64 07:21:23 INFO - PROCESS | 6009 | Values: 383.5 384.0 388.0 393.2 398.9 12825.4 15201.9 15608.8 17011.2 17288.7 15286.9 15521.1 15882.1 16474.3 16484.2 5141.0 5179.8 5214.3 5321.5 5356.8 5272.5 5275.5 5288.6 5304.6 5311.8 5026.0 5262.1 5266.8 5271.5 5278.6 5228.2 5250.2 5280.6 5286.4 5292.6 4492.7 4678.0 4709.0 4727.6 4751.0 19857.1 20098.5 20127.9 20181.5 20361.4 1834.5 1851.0 1896.9 1914.6 2033.1 12523.3 13408.1 13510.8 13621.2 13711.1 1791.2 1802.9 1810.2 1813.4 1822.8 67838.0 68297.7 68474.0 68784.3 69158.3 9282.6 9305.6 9723.6 9907.0 9922.3 11836.8 12771.8 13386.2 13413.3 13492.3 7106.5 7177.2 7225.5 7253.6 7342.9 6848.3 6867.2 6959.3 7064.3 7067.4 6010.9 6213.9 6213.9 6232.8 6260.7 1810.9 1889.1 1889.4 1891.3 1905.7 836.2 872.8 923.2 927.4 947.7 15207.7 16189.4 16585.7 16974.7 17062.1 868.7 898.0 901.1 903.9 966.3 9055.0 9499.4 9699.4 9737.1 10017.6 357694.0 362429.0 363526.0 365395.0 370790.0 81125.2 81710.0 82301.6 84048.0 84333.6 959.2 968.8 977.3 997.1 997.9 15146.6 15149.5 15292.2 15307.5 15610.3 29124.4 30421.1 35059.0 35219.5 35898.0 42319.2 43001.8 43729.6 46163.0 48765.3 7239.2 7287.4 7331.9 7370.7 7596.8 9575.4 11002.2 11223.4 11227.5 11318.7 9156.5 9302.9 9368.4 9395.8 9640.9 9511.7 9522.9 9684.4 9892.2 9992.8 9426.4 9445.2 9467.1 9777.6 9883.2 7253.7 7260.0 7357.0 7434.1 7458.4 8840.4 9191.3 9726.6 10138.9 10212.2 07:21:23 INFO - PROCESS | 6009 | 07:21:23 INFO - PROCESS | 6009 | [#3] mootools.html Cycles:180 Average:5077.90 Median:4973.37 stddev:2824.74 (56.8%) stddev-sans-first:2819.48 07:21:23 INFO - PROCESS | 6009 | Values: 1447.2 1483.5 1635.9 1761.2 1799.2 6691.3 7426.6 7492.8 7763.7 7767.5 7314.5 7353.0 7372.7 7411.2 7427.3 2222.8 2241.5 2263.0 2265.6 2274.3 2183.3 2188.1 2223.0 2224.6 2233.3 2225.8 2227.1 2252.4 2261.2 2261.6 2206.6 2207.2 2212.6 2216.5 2217.7 2198.9 2200.5 2203.1 2208.2 2215.0 7737.8 7768.9 7773.0 7775.3 7776.6 4604.4 4720.8 4755.3 4760.2 4800.2 2747.4 2925.4 2954.5 2961.3 2969.5 907.1 913.3 922.6 929.2 931.9 10397.4 10412.4 10421.2 10439.4 10447.8 4192.3 4308.2 4320.1 4363.6 4424.8 8825.7 8864.3 8865.6 8893.6 8897.2 4656.4 4701.2 4752.2 4757.0 4758.1 3653.7 4182.8 4228.2 4292.9 4322.7 3602.3 3653.2 3740.8 3754.9 3757.8 1186.3 1223.4 1231.8 1241.9 1243.4 613.5 653.3 754.9 813.6 829.5 4826.6 4932.3 4933.3 5052.7 5204.4 829.7 878.1 882.1 889.5 909.9 3399.6 3449.5 3451.2 3512.6 3526.6 9464.1 9676.6 9715.6 9741.0 9827.3 9651.3 9675.9 9677.0 9741.9 9746.4 7210.2 7369.4 7418.9 7491.9 7495.0 4785.3 4940.3 4958.6 4988.1 5034.9 8918.3 8986.1 9008.6 9022.0 9066.1 8878.9 9240.4 9242.5 9242.9 9251.7 5659.0 6114.4 6400.1 6471.7 6576.7 7224.5 7245.5 7260.3 7282.7 7343.6 6298.2 6465.7 6524.6 6689.1 6691.1 6469.6 6560.4 6601.0 6656.0 6695.4 5781.0 5898.3 5916.7 5937.8 5949.7 4379.3 4476.9 4500.4 4532.7 4537.9 4474.3 4489.5 4536.9 4554.2 4585.5 07:21:23 INFO - PROCESS | 6009 | 07:21:23 INFO - PROCESS | 6009 | [#4] prototype.html Cycles:180 Average:4501.86 Median:4961.13 stddev:1323.05 (26.7%) stddev-sans-first:1288.81 07:21:23 INFO - PROCESS | 6009 | Values: 309.8 314.6 315.8 318.9 321.2 4940.6 5049.7 5068.2 5095.9 5102.7 4937.7 4940.9 4942.7 4979.6 4983.7 3707.1 3839.9 3924.8 3930.0 3931.8 3930.9 3935.4 3957.6 3968.7 3969.0 3936.1 3943.6 3949.0 3957.1 3958.6 3872.7 3918.1 3936.9 3961.5 3964.6 3476.7 3483.5 3505.4 3508.2 3514.6 4745.8 4799.2 4806.7 4809.8 4815.3 4354.3 4491.3 4508.4 4516.8 4535.4 5178.2 5223.7 5235.6 5269.2 5274.5 3776.7 3784.9 3798.6 3799.2 3836.7 5385.4 5461.6 5495.6 5502.9 5526.8 3894.9 3904.3 3912.7 3924.7 3927.3 3956.3 3963.9 3970.6 3978.6 3981.8 4455.3 4479.1 4485.7 4493.5 4496.6 5110.1 5194.6 5200.3 5200.8 5210.5 1432.6 1443.1 1452.8 1454.2 1454.9 917.8 963.2 998.1 1000.5 1005.2 4590.2 4703.9 4725.7 4736.0 4738.7 5463.4 5470.3 5489.1 5491.8 5522.1 4563.0 4634.0 4695.5 4700.7 4711.7 3113.0 3124.8 3126.8 3133.8 3155.1 5415.1 5460.9 5477.7 5479.4 5499.2 5755.6 5915.9 5946.9 6004.9 6009.6 5426.0 5445.8 5462.3 5478.3 5495.6 5641.0 5817.3 5822.8 5830.6 5856.2 5701.8 5715.7 5725.8 5742.9 5749.5 5444.5 5466.2 5495.5 5502.9 5504.5 3988.5 4011.9 4055.9 4061.3 4066.0 5742.1 5816.9 5828.1 5831.5 5849.0 5589.2 5604.2 5640.5 5643.2 5655.9 5427.3 5599.4 5635.1 5643.2 5659.7 5526.2 5544.7 5547.8 5571.0 5574.4 5007.4 5028.8 5251.2 5259.9 5285.7 5147.7 5160.5 5164.6 5166.9 5169.2 07:21:23 INFO - PROCESS | 6009 | 07:21:23 INFO - PROCESS | 6009 | [#5] yui.html Cycles:180 Average:12552.02 Median:46435.15 stddev:14611.41 (31.5%) stddev-sans-first:14625.03 07:21:23 INFO - PROCESS | 6009 | Values: 643.5 714.4 719.7 787.5 800.2 10888.4 10895.4 10958.1 10982.7 11973.9 11722.5 11998.5 12117.2 12135.0 12220.3 786.5 808.2 808.4 808.5 809.4 636.1 788.1 804.2 814.0 822.0 848.2 850.4 857.7 857.8 858.2 847.2 852.8 852.8 852.8 853.9 620.7 626.4 626.8 627.5 628.4 11897.6 11901.4 11916.8 11925.9 11942.2 12156.1 12260.6 12485.9 12599.8 12640.3 9485.5 9598.4 9620.9 9758.1 9845.0 3283.1 3314.6 3315.6 3329.9 3407.5 43006.6 43106.1 43120.8 43311.0 44310.1 9420.9 9667.5 9761.3 10200.1 10233.9 16847.4 16905.1 16976.7 17075.7 17091.9 6378.4 6655.9 6665.9 6782.9 6806.9 3531.9 3552.0 3557.8 3577.0 3615.2 2766.6 2816.2 2817.5 2820.9 2824.9 487.6 502.0 502.9 504.7 509.2 557.7 570.6 571.3 595.7 610.9 7294.4 7406.9 7417.9 7535.2 7624.0 481.5 527.6 555.7 570.0 570.4 3667.8 3764.9 3795.0 3809.2 3887.4 51148.0 56049.0 56383.0 56392.0 56444.4 41907.0 44692.8 45273.8 47596.5 48623.0 43331.8 44212.0 44354.0 44844.6 44968.0 7547.7 7754.8 7796.2 7893.6 7955.2 29495.3 29507.7 29711.9 30038.0 30213.4 36598.8 38365.4 38859.8 38946.8 39752.6 10002.3 10038.2 10129.4 10154.6 10206.3 10806.3 10833.4 10933.8 11469.8 11757.1 9814.0 10199.3 10287.8 10509.5 10692.8 10541.5 10598.5 10681.9 10789.6 10840.6 9547.1 9780.7 9850.4 10100.3 10440.1 8953.1 9008.2 9034.6 9095.1 9249.3 7698.5 7987.4 8050.6 8097.6 8212.5 07:21:23 INFO - PROCESS | 6009 | -------- Summary: end -------- 07:21:23 INFO - PROCESS | 6009 | 07:21:24 INFO - TEST-INFO | 6009: exit 0 07:21:24 INFO - TEST-OK | dromaeo_css | took 1115052ms 07:21:24 INFO - TEST-START | kraken 07:21:24 INFO - operating with platform_type : linux_ 07:21:24 INFO - Initialising browser for kraken test... 07:21:24 INFO - TEST-INFO | started process 6247 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO4crBN/profile http://localhost:51862/getInfo.html) 07:21:28 INFO - PROCESS | 6247 | 07:21:28 INFO - PROCESS | 6247 | (process:6313): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:21:28 INFO - PROCESS | 6247 | __metrics Screen width/height:1600/1200 07:21:28 INFO - PROCESS | 6247 | colorDepth:24 07:21:28 INFO - PROCESS | 6247 | Browser inner width/height: 1024/697 07:21:28 INFO - PROCESS | 6247 | __metrics 07:21:29 ERROR - PROCESS | 6247 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 07:21:30 INFO - TEST-INFO | 6247: exit 0 07:21:30 INFO - Browser initialized. 07:21:30 INFO - Running cycle 1/1 for kraken test... 07:21:30 INFO - TEST-INFO | started process 6365 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO4crBN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:21:32 INFO - PROCESS | 6365 | 07:21:32 INFO - PROCESS | 6365 | (process:6425): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:21:42 INFO - PROCESS | 6365 | RSS: Main: 166342656 07:21:42 INFO - PROCESS | 6365 | 07:21:45 INFO - PROCESS | 6365 | Cycle 1(1): loaded http://localhost:51862/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51862/tests/kraken/driver.html?testName=audio-beat-detection) 07:21:46 INFO - PROCESS | 6365 | RSS: Main: 170426368 07:21:46 INFO - PROCESS | 6365 | 07:21:49 INFO - PROCESS | 6365 | Cycle 1(1): loaded http://localhost:51862/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51862/tests/kraken/driver.html?testName=audio-dft) 07:21:49 INFO - PROCESS | 6365 | RSS: Main: 173572096 07:21:49 INFO - PROCESS | 6365 | 07:21:52 INFO - PROCESS | 6365 | Cycle 1(1): loaded http://localhost:51862/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51862/tests/kraken/driver.html?testName=audio-fft) 07:21:53 INFO - PROCESS | 6365 | RSS: Main: 166240256 07:21:53 INFO - PROCESS | 6365 | 07:21:55 INFO - PROCESS | 6365 | Cycle 1(1): loaded http://localhost:51862/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51862/tests/kraken/driver.html?testName=audio-oscillator) 07:21:55 INFO - PROCESS | 6365 | RSS: Main: 166080512 07:21:55 INFO - PROCESS | 6365 | 07:21:58 INFO - PROCESS | 6365 | Cycle 1(1): loaded http://localhost:51862/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51862/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:21:58 INFO - PROCESS | 6365 | RSS: Main: 166248448 07:21:58 INFO - PROCESS | 6365 | 07:22:02 INFO - PROCESS | 6365 | Cycle 1(1): loaded http://localhost:51862/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51862/tests/kraken/driver.html?testName=imaging-darkroom) 07:22:02 INFO - PROCESS | 6365 | RSS: Main: 166739968 07:22:02 INFO - PROCESS | 6365 | 07:22:06 INFO - PROCESS | 6365 | Cycle 1(1): loaded http://localhost:51862/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51862/tests/kraken/driver.html?testName=imaging-desaturate) 07:22:06 INFO - PROCESS | 6365 | RSS: Main: 165937152 07:22:06 INFO - PROCESS | 6365 | 07:22:09 INFO - PROCESS | 6365 | Cycle 1(1): loaded http://localhost:51862/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51862/tests/kraken/driver.html?testName=json-parse-financial) 07:22:10 INFO - PROCESS | 6365 | RSS: Main: 166920192 07:22:10 INFO - PROCESS | 6365 | 07:22:12 INFO - PROCESS | 6365 | Cycle 1(1): loaded http://localhost:51862/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51862/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:22:12 INFO - PROCESS | 6365 | RSS: Main: 167272448 07:22:12 INFO - PROCESS | 6365 | 07:22:14 INFO - PROCESS | 6365 | Cycle 1(1): loaded http://localhost:51862/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51862/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:22:15 INFO - PROCESS | 6365 | RSS: Main: 167145472 07:22:15 INFO - PROCESS | 6365 | 07:22:17 INFO - PROCESS | 6365 | Cycle 1(1): loaded http://localhost:51862/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51862/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:22:18 INFO - PROCESS | 6365 | RSS: Main: 167464960 07:22:18 INFO - PROCESS | 6365 | 07:22:20 INFO - PROCESS | 6365 | Cycle 1(1): loaded http://localhost:51862/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51862/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:22:21 INFO - PROCESS | 6365 | RSS: Main: 168185856 07:22:21 INFO - PROCESS | 6365 | 07:22:24 INFO - PROCESS | 6365 | Cycle 1(1): loaded http://localhost:51862/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51862/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:22:25 INFO - PROCESS | 6365 | RSS: Main: 167645184 07:22:25 INFO - PROCESS | 6365 | 07:22:26 INFO - PROCESS | 6365 | Cycle 1(1): loaded http://localhost:51862/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51862/tests/kraken/driver.html?testName=ai-astar) 07:22:27 INFO - PROCESS | 6365 | RSS: Main: 169422848 07:22:27 INFO - PROCESS | 6365 | 07:22:27 INFO - PROCESS | 6365 | __start_tp_report 07:22:27 INFO - PROCESS | 6365 | _x_x_mozilla_page_load 07:22:27 INFO - PROCESS | 6365 | _x_x_mozilla_page_load_details 07:22:27 INFO - PROCESS | 6365 | |i|pagename|runs| 07:22:27 INFO - PROCESS | 6365 | |0;ai-astar;115;107;115;117;114;128;116;114;114;113 07:22:27 INFO - PROCESS | 6365 | |1;audio-beat-detection;165;136;152;190;134;165;170;132;188;132 07:22:27 INFO - PROCESS | 6365 | |2;audio-dft;162;162;166;174;164;163;163;164;165;164 07:22:27 INFO - PROCESS | 6365 | |3;audio-fft;74;76;78;157;79;75;75;74;155;75 07:22:27 INFO - PROCESS | 6365 | |4;audio-oscillator;95;94;146;94;93;95;149;94;95;136 07:22:27 INFO - PROCESS | 6365 | |5;imaging-gaussian-blur;118;119;117;119;117;118;117;118;118;119 07:22:27 INFO - PROCESS | 6365 | |6;imaging-darkroom;147;151;147;149;146;147;147;148;148;147 07:22:27 INFO - PROCESS | 6365 | |7;imaging-desaturate;96;96;96;95;97;96;95;96;98;95 07:22:27 INFO - PROCESS | 6365 | |8;json-parse-financial;67;67;72;67;67;68;67;67;67;67 07:22:27 INFO - PROCESS | 6365 | |9;json-stringify-tinderbox;64;65;64;64;65;64;65;65;64;70 07:22:27 INFO - PROCESS | 6365 | |10;stanford-crypto-aes;80;79;79;79;79;79;80;80;107;79 07:22:27 INFO - PROCESS | 6365 | |11;stanford-crypto-ccm;133;138;132;131;138;129;129;131;146;133 07:22:27 INFO - PROCESS | 6365 | |12;stanford-crypto-pbkdf2;182;176;176;179;176;181;172;177;184;188 07:22:27 INFO - PROCESS | 6365 | |13;stanford-crypto-sha256-iterative;75;74;74;74;74;71;73;73;77;73 07:22:27 INFO - PROCESS | 6365 | __end_tp_report 07:22:27 INFO - PROCESS | 6365 | __start_cc_report 07:22:27 INFO - PROCESS | 6365 | _x_x_mozilla_cycle_collect,914 07:22:27 INFO - PROCESS | 6365 | __end_cc_report 07:22:27 INFO - PROCESS | 6365 | __startTimestamp1461594147128__endTimestamp 07:22:27 INFO - PROCESS | 6365 | 07:22:27 INFO - PROCESS | 6365 | ------- Summary: start ------- 07:22:27 INFO - PROCESS | 6365 | Number of tests: 14 07:22:27 INFO - PROCESS | 6365 | 07:22:27 INFO - PROCESS | 6365 | [#0] ai-astar Cycles:10 Average:115.30 Median:115.00 stddev:5.21 (4.5%) stddev-sans-first:5.52 07:22:27 INFO - PROCESS | 6365 | Values: 115.0 107.0 115.0 117.0 114.0 128.0 116.0 114.0 114.0 113.0 07:22:27 INFO - PROCESS | 6365 | 07:22:27 INFO - PROCESS | 6365 | [#1] audio-beat-detection Cycles:10 Average:156.40 Median:165.00 stddev:22.58 (13.7%) stddev-sans-first:23.73 07:22:27 INFO - PROCESS | 6365 | Values: 165.0 136.0 152.0 190.0 134.0 165.0 170.0 132.0 188.0 132.0 07:22:27 INFO - PROCESS | 6365 | 07:22:27 INFO - PROCESS | 6365 | [#2] audio-dft Cycles:10 Average:164.70 Median:164.00 stddev:3.50 (2.1%) stddev-sans-first:3.57 07:22:27 INFO - PROCESS | 6365 | Values: 162.0 162.0 166.0 174.0 164.0 163.0 163.0 164.0 165.0 164.0 07:22:27 INFO - PROCESS | 6365 | 07:22:27 INFO - PROCESS | 6365 | [#3] audio-fft Cycles:10 Average:91.80 Median:75.00 stddev:33.88 (45.2%) stddev-sans-first:35.32 07:22:27 INFO - PROCESS | 6365 | Values: 74.0 76.0 78.0 157.0 79.0 75.0 75.0 74.0 155.0 75.0 07:22:27 INFO - PROCESS | 6365 | 07:22:27 INFO - PROCESS | 6365 | [#4] audio-oscillator Cycles:10 Average:109.10 Median:94.00 stddev:24.08 (25.6%) stddev-sans-first:24.99 07:22:27 INFO - PROCESS | 6365 | Values: 95.0 94.0 146.0 94.0 93.0 95.0 149.0 94.0 95.0 136.0 07:22:27 INFO - PROCESS | 6365 | 07:22:27 INFO - PROCESS | 6365 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 07:22:27 INFO - PROCESS | 6365 | Values: 118.0 119.0 117.0 119.0 117.0 118.0 117.0 118.0 118.0 119.0 07:22:27 INFO - PROCESS | 6365 | 07:22:27 INFO - PROCESS | 6365 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:147.50 stddev:1.42 (1.0%) stddev-sans-first:1.48 07:22:27 INFO - PROCESS | 6365 | Values: 147.0 151.0 147.0 149.0 146.0 147.0 147.0 148.0 148.0 147.0 07:22:27 INFO - PROCESS | 6365 | 07:22:27 INFO - PROCESS | 6365 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.94 (1.0%) stddev-sans-first:1.00 07:22:27 INFO - PROCESS | 6365 | Values: 96.0 96.0 96.0 95.0 97.0 96.0 95.0 96.0 98.0 95.0 07:22:27 INFO - PROCESS | 6365 | 07:22:27 INFO - PROCESS | 6365 | [#8] json-parse-financial Cycles:10 Average:67.60 Median:67.00 stddev:1.58 (2.4%) stddev-sans-first:1.66 07:22:27 INFO - PROCESS | 6365 | Values: 67.0 67.0 72.0 67.0 67.0 68.0 67.0 67.0 67.0 67.0 07:22:27 INFO - PROCESS | 6365 | 07:22:27 INFO - PROCESS | 6365 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:1.83 (2.8%) stddev-sans-first:1.90 07:22:27 INFO - PROCESS | 6365 | Values: 64.0 65.0 64.0 64.0 65.0 64.0 65.0 65.0 64.0 70.0 07:22:27 INFO - PROCESS | 6365 | 07:22:27 INFO - PROCESS | 6365 | [#10] stanford-crypto-aes Cycles:10 Average:82.10 Median:79.00 stddev:8.76 (11.1%) stddev-sans-first:9.26 07:22:27 INFO - PROCESS | 6365 | Values: 80.0 79.0 79.0 79.0 79.0 79.0 80.0 80.0 107.0 79.0 07:22:27 INFO - PROCESS | 6365 | 07:22:27 INFO - PROCESS | 6365 | [#11] stanford-crypto-ccm Cycles:10 Average:134.00 Median:133.00 stddev:5.27 (4.0%) stddev-sans-first:5.58 07:22:27 INFO - PROCESS | 6365 | Values: 133.0 138.0 132.0 131.0 138.0 129.0 129.0 131.0 146.0 133.0 07:22:27 INFO - PROCESS | 6365 | 07:22:27 INFO - PROCESS | 6365 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.10 Median:180.00 stddev:4.70 (2.6%) stddev-sans-first:4.87 07:22:27 INFO - PROCESS | 6365 | Values: 182.0 176.0 176.0 179.0 176.0 181.0 172.0 177.0 184.0 188.0 07:22:27 INFO - PROCESS | 6365 | 07:22:27 INFO - PROCESS | 6365 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.80 Median:74.00 stddev:1.55 (2.1%) stddev-sans-first:1.58 07:22:27 INFO - PROCESS | 6365 | Values: 75.0 74.0 74.0 74.0 74.0 71.0 73.0 73.0 77.0 73.0 07:22:27 INFO - PROCESS | 6365 | -------- Summary: end -------- 07:22:27 INFO - PROCESS | 6365 | 07:22:28 INFO - TEST-INFO | 6365: exit 0 07:22:28 INFO - TEST-OK | kraken | took 63896ms 07:22:28 INFO - SUITE-END | took 1178s 07:22:28 INFO - Completed test suite (00:19:39) 07:22:28 INFO - javascript benchmark 07:22:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2624.2127361791463, 2666.679998400192, 2709.078913169522, 2719.768819650331, 2720.9047683331087, 4753.833615823442, 4775.474697783246, 4787.13831510328, 4805.295794867708, 4838.104950584145, 4706.435227772672, 4793.880152996177, 4843.443004054535, 4844.128056949757, 4915.950840491594, 4395.077033822901, 4426.358178064179, 4455.84404545841, 4474.440694913136, 4520.886977825548, 642.187824275483, 4297.570242975693, 4335.891602709926, 4346.152500262434, 4383.211022016036, 4443.911121777546, 4451.065276291983, 4451.755153466558, 4473.731576105444, 4504.459464864204, 4459.665525085632, 4460.598546130831, 4467.955320446787, 4473.127740090684, 4499.775011249457, 4222.9577704223175, 4359.367891655692, 4400.691951563392, 4425.734455932622, 4442.62237709795, 4638.350630911675, 4695.976520117411, 4704.364910737041, 4708.152532544141, 4729.810807567727, 4929.876753081166, 5136.152534831748, 5151.098557752378, 5167.844964651066, 5185.740712964374, 5109.693418394908, 5127.564157046656, 5167.863070124567, 5184.274201611777, 5200.115980283361, 4742.0515896820425, 4785.760711964457, 4791.6645834791925, 4809.807607695688, 4834.226523756182, 5115.71863547501, 5244.265802787613, 5266.104762190437, 5272.489550109937, 5272.9736351318, 5095.821646242363, 5107.131787596118, 5109.335786347751, 5111.361079865017, 5159.974200128975, 5183.2743415921805, 5193.922091168635, 5194.402643696023, 5194.506521880416, 5253.080710875582, 4826.613870890391, 5037.269595908573, 5102.183650615883, 5137.049645815536, 5151.922721159186, 5074.695518268915, 5101.05630458359, 5110.182370820651, 5113.821016264413, 5134.332536770196, 4335.436393268855, 4335.523092459827, 4344.587264209895, 4367.71609845359, 4375.256206444912, 3685.8894233173046, 3736.75711078779, 3786.848526058982, 3798.3732684107367, 3860.0542866997766, 4355.673324500612, 4455.1980643484485, 4469.910601787946, 4474.463064432224, 4488.304312831517, 5194.948050519522, 5211.114110601206, 5212.113940630102, 5212.765425555859, 5258.684478931276, 4385.079133382025, 4456.732596044183, 4456.997175635521, 4518.796654150571, 4595.425571803525, 4524.524924882906, 4549.545045495424, 4605.078984203173, 4675.158471475099, 4697.248440249612, 4860.659753817199, 4896.045271172087, 4907.975460122677, 4909.975450122726, 4950.702957822542, 5216.40011398694, 5217.556507696737, 5219.2953951216095, 5219.76511057011, 5222.503862133091, 4729.55069268419, 4831.4202295724735, 4882.6826256293225, 4908.969116485578, 4935.851924442272, 5074.82238121664, 5077.619178561548, 5087.0, 5093.337866077386, 5145.691258524501, 4962.578180854523, 5169.379674439091, 5177.068127737043, 5188.351456067991, 5189.844304670866, 4945.505449455026, 4983.476734942778, 5003.874903127451, 5009.298698182331, 5012.649114561946, 4973.477784832685, 4980.203167493329, 5009.373828271466, 5037.546620804145, 5082.949170508247, 4768.57082862544, 4868.659193856396, 4934.210526315772, 4949.158643030765, 4993.625478089085, 4990.775415106256, 5053.7473126344275, 5055.191169412877, 5063.594912407072, 5115.590752739847, 4940.555350018516, 4960.851174464772, 4963.553280204799, 4965.0318187953, 5027.170516864677], "value": 4695.903540858047, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.9421057894211, 588.3028611095851, 610.5909040942568, 618.3229363846592, 650.3366566102573, 34018.48972265418, 35179.64820351796, 35536.0, 35575.46636800447, 35583.46624800627, 37530.0, 38177.809110954404, 38234.80882595583, 38299.80850095746, 38307.23385532288, 7692.9230707692905, 7841.6079196040255, 7845.2547008034435, 7871.763847084597, 7878.6848526059175, 7621.885671714928, 7741.187175346592, 7770.494917830351, 7899.28906398424, 7985.281324680806, 7957.244061814147, 8016.158303378149, 8019.318357939582, 8028.879566806502, 8043.195680431969, 7927.960360198191, 7957.124716281204, 7973.880391794128, 7981.48120372174, 8008.719694810712, 7838.686452541891, 7964.920350796476, 7969.163237859999, 7977.48146370484, 8036.156203598596, 38000.80999595012, 38415.8079209605, 38423.80788096042, 38659.8067009666, 38696.0, 2826.844523551204, 2896.6234389529436, 2902.2454161917844, 2926.9853650731825, 2936.9412611747857, 29239.41521169586, 29367.2658183545, 29481.705182948324, 29824.254393640116, 29922.55116173259, 3428.468587368962, 3451.516787649731, 3468.1156305142026, 3491.6508349165133, 3491.8777842775635, 176346.0, 176422.65041447105, 176608.0, 177390.0, 177423.0, 48058.519414806105, 48095.278570821465, 48131.27803082956, 48242.27636585454, 48337.27494087591, 52153.47846521562, 52366.47633523692, 52410.73794631002, 52490.21264681033, 56251.71874140685, 13270.270135142468, 13429.865701343057, 13463.0, 13473.191608503324, 13496.730065398637, 10555.577776888838, 10582.417967011888, 10600.098991585648, 10612.840807387895, 10675.519601617945, 18075.186616602285, 18209.63580728378, 18220.635587288445, 18283.360082397052, 18397.264109435473, 6893.172819261721, 7048.577085374894, 7125.50121491501, 7307.525010874276, 7353.595552244571, 780.8945792318078, 790.774629230678, 859.1923591823665, 873.1661263493348, 960.2462067277154, 28165.43669126606, 28390.574141387897, 28687.56968645472, 28855.134345969655, 28915.42169156605, 971.5385192033727, 990.3513198854762, 1006.8873894346788, 1026.2918586175665, 1054.8365003424328, 15330.770038449433, 15366.231688415535, 15451.150186739613, 15630.06219626826, 15736.68526629461, 328849.0, 338097.0, 338389.0, 339409.0, 339821.0, 48242.0, 48717.75641121772, 49301.50698492969, 49493.257601136014, 49563.50436495661, 1178.7701398227264, 1214.860291066521, 1227.312704885267, 1231.1874163052341, 1260.7478504298992, 26822.463550728487, 27455.45089098247, 27920.44159116847, 28009.859950700116, 28138.577921330787, 42429.0, 42468.78765606152, 42568.78715606402, 42700.78649606856, 42716.35925461183, 289663.0, 290507.0, 291931.0, 292565.0, 293752.0, 25366.873165634053, 25602.61596076023, 25901.0, 26033.219003429927, 26269.34326641849, 42022.36966445567, 42458.57541424546, 42583.14833703371, 42686.78656606697, 43399.56600434081, 35245.64754352424, 35814.64185358113, 35868.28263434769, 36059.81970090238, 36952.44571331486, 35143.64856351506, 35305.82347088351, 35331.64668353284, 35749.821250893576, 35904.46143307905, 31590.210244743146, 33102.33795324128, 33147.66852331446, 35854.82072589621, 35951.64048359483, 28198.295042624097, 29855.701442985293, 31219.687803121677, 31733.206669832514, 31788.205294867814, 24679.136230231856, 24830.130945416822, 24855.254342369757, 24899.62650560279, 24927.626085608368], "value": 17080.97730449301, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.5414989914646, 383.9923201535969, 387.96120387961207, 393.201800345299, 398.9182217645383, 12825.422855971481, 15201.923990380046, 15608.765868511953, 17011.234494447763, 17288.74066888996, 15286.923565382158, 15521.146336951491, 15882.126483043428, 16474.258658360373, 16484.175791210422, 5141.0, 5179.8446046618565, 5214.296070030554, 5321.547668448186, 5356.812511562096, 5272.525472707455, 5275.49882761139, 5288.60335474839, 5304.575633949294, 5311.760970756325, 5026.045051440233, 5262.079136151177, 5266.8419947401635, 5271.499207575274, 5278.577713782888, 5228.189630607224, 5250.238715386286, 5280.551153151987, 5286.392064912527, 5292.550133238679, 4492.68551201416, 4678.041001594699, 4708.952910470885, 4727.64542659302, 4751.002289519205, 19857.106430210675, 20098.497537561532, 20127.899360503252, 20181.495462613406, 20361.389158325273, 1834.5046837353839, 1850.9722354164699, 1896.924123035077, 1914.5979344337707, 2033.0647901964967, 12523.311217883012, 13408.061435699505, 13510.797338039938, 13621.182729036289, 13711.108777929403, 1791.2208189437636, 1802.8647851411197, 1810.1944634637591, 1813.38344962712, 1822.8086050964723, 67838.0, 68297.65851170712, 68474.0, 68784.3121568783, 69158.3084169157, 9282.628694852265, 9305.581248843819, 9723.61105555784, 9906.950465247772, 9922.305438619227, 11836.763264734656, 12771.808422873664, 13386.19682819034, 13413.262270575213, 13492.257925813978, 7106.502544821917, 7177.246389129066, 7225.530340527849, 7253.601051942193, 7342.853142937218, 6848.3494068063455, 6867.244603093655, 6959.338862808025, 7064.32888875556, 7067.363937245673, 6010.939890601126, 6213.875722485525, 6213.937860621336, 6232.8130156095385, 6260.7495700171485, 1810.9094545272683, 1889.0743535667425, 1889.3859495663964, 1891.328578354692, 1905.6855618823017, 836.2097817562467, 872.7905302727299, 923.2475532441039, 927.4388994658269, 947.7014740356904, 15207.695846083016, 16189.433369832235, 16585.668286634198, 16974.660506789794, 17062.061586612606, 868.70898249086, 897.9865302020474, 901.1394118616705, 903.9096090390908, 966.2897770138942, 9055.0, 9499.43003419797, 9699.418034917928, 9737.123658870736, 10017.649382271586, 357694.0, 362429.0, 363526.0, 365395.0, 370790.0, 81125.18874811176, 81710.0, 82301.58849205716, 84048.0, 84333.57833210795, 959.1703176752059, 968.801395713877, 977.2524019125375, 997.1275134257525, 997.8802543694803, 15146.621334466727, 15149.545513634608, 15292.158931258888, 15307.46423875159, 15610.297536611108, 29124.3635930564, 30421.109994550483, 35059.0, 35219.47170792492, 35898.0, 42319.1536169281, 43001.78499107484, 43729.56270437255, 46163.0, 48765.268520972924, 7239.203687594466, 7287.380572651172, 7331.890021649573, 7370.6683199255085, 7596.81007974805, 9575.377600455948, 11002.22984391117, 11223.4388280584, 11227.49476273586, 11318.717032074264, 9156.496392698466, 9302.860457093284, 9368.39105458143, 9395.765105872408, 9640.891297500877, 9511.66709165176, 9522.85715714251, 9684.370515916444, 9892.159166470643, 9992.750181245236, 9426.387284826464, 9445.244380449685, 9467.053294670477, 9777.608895644094, 9883.159931405911, 7253.673584688596, 7259.963700181465, 7357.0, 7434.070741157356, 7458.366038886756, 8840.381173317806, 9191.310651701282, 9726.562304696165, 10138.89861101409, 10212.183025358103], "value": 8168.358475469914, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1447.1678784698797, 1483.4956114920928, 1635.9018458892467, 1761.1898526677728, 1799.199356286453, 6691.26396096429, 7426.554406735593, 7492.775216743493, 7763.689452421911, 7767.495112817663, 7314.487985840993, 7353.0441042664515, 7372.7050917963215, 7411.221821708724, 7427.25727427257, 2222.822174226062, 2241.5068684889297, 2263.0495192019393, 2265.6035193841094, 2274.2722328854775, 2183.3449965010514, 2188.070070220158, 2222.9888850555726, 2224.5884511365366, 2233.2741858895843, 2225.8441909066373, 2227.0535022615404, 2252.4368907773055, 2261.185973049709, 2261.6268315727884, 2206.569718904806, 2207.227470385368, 2212.623853944833, 2216.4791274050745, 2217.6562632792024, 2198.933517244135, 2200.548887478063, 2203.0747086223823, 2208.1719355241785, 2215.0, 7737.845243095163, 7768.922310776877, 7772.961135194344, 7775.300222979959, 7776.611169441505, 4604.355390245369, 4720.787564559603, 4755.286706993978, 4760.166970780134, 4800.1839687252905, 2747.4367754610457, 2925.3856690095104, 2954.4534261161753, 2961.318896653782, 2969.5248760198265, 907.1472815553359, 913.3423934766957, 922.6355589542161, 929.1962452478557, 931.8788557487551, 10397.428141452217, 10412.42731649759, 10421.166306695446, 10439.42583157926, 10447.79104417915, 4192.329227323614, 4308.159908817813, 4320.071184695305, 4363.585459381354, 4424.756638384855, 8825.69110081144, 8864.335174861782, 8865.601047952858, 8893.644254229888, 8897.243734282529, 4656.4412270527755, 4701.200795864711, 4752.1683705351425, 4757.024809913959, 4758.119747846659, 3653.725970552219, 4182.811773470201, 4228.175505776406, 4292.914141717149, 4322.740635561813, 3602.2615363850346, 3653.214558869856, 3740.7942563159286, 3754.887353379403, 3757.812109394519, 1186.32379543661, 1223.3760782001066, 1231.7536492701495, 1241.919275247106, 1243.4155946705034, 613.5183880653666, 653.3270731146831, 754.9320561149523, 813.6460639621783, 829.4649950781712, 4826.61387089032, 4932.28481870134, 4933.333999910038, 5052.722100284446, 5204.4014938281825, 829.7261903571807, 878.0867897386646, 882.148726478951, 889.5285498685707, 909.8726178335038, 3399.6260411354733, 3449.534312867781, 3451.2062225688233, 3512.5609298837644, 3526.647335266453, 9464.100910413637, 9676.612935482643, 9715.562799674031, 9740.951295243478, 9827.312088153903, 9651.276154288456, 9675.854862177073, 9676.95161524202, 9741.9025809741, 9746.415215086976, 7210.206877243499, 7369.447291453055, 7418.851622967511, 7491.8501629967095, 7494.999999999891, 4785.306130610972, 4940.283658869515, 4958.628102892226, 4988.102141614544, 5034.949650503595, 8918.286537077149, 8986.101389860962, 9008.63965441375, 9022.0, 9066.09339066088, 8878.911210887809, 9240.399374040666, 9242.491662958602, 9242.907570924204, 9251.722448326562, 5659.0, 6114.38856114385, 6400.103985442135, 6471.741130354922, 6576.736930522726, 7224.494285399972, 7245.529040612343, 7260.2739726026975, 7282.745103921337, 7343.559386436831, 6298.1812364392335, 6465.709043092978, 6524.641144737085, 6689.130413046468, 6691.063251144941, 6469.644169570719, 6560.44236239925, 6601.0, 6656.0348749430095, 6695.363940425652, 5781.046127388934, 5898.262717160355, 5916.704164791657, 5937.7921772737745, 5949.672767997802, 4379.321205213197, 4476.888077797951, 4500.437445319335, 4532.66005049616, 4537.909241815079, 4474.306482495218, 4489.483709373464, 4536.88657783558, 4554.20301447252, 4585.518520555293], "value": 4110.276976127655, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.78160396920174, 314.5847481324651, 315.80735751191753, 318.92186414328484, 321.15696297219796, 4940.6047516198705, 5049.747512624373, 5068.1890897456415, 5095.923561146581, 5102.719350435725, 4937.679050861691, 4940.851774446773, 4942.654014218997, 4979.601631869451, 4983.651144419883, 3707.110293529554, 3839.8656047038357, 3924.7645141291473, 3930.0, 3931.842726290945, 3930.921381572367, 3935.3703407454814, 3957.6148348078086, 3968.6825053995753, 3969.0, 3936.0946982194114, 3943.6450719435247, 3949.012746813297, 3957.0915377197734, 3958.584348643394, 3872.6901847852105, 3918.0792513759243, 3936.8622098226424, 3961.4652021977095, 3964.623360780721, 3476.6523347665284, 3483.477478378238, 3505.3690335739557, 3508.245727168671, 3514.595821480537, 4745.786439610226, 4799.18413869643, 4806.663533552653, 4809.759512024385, 4815.277708343741, 4354.325079612665, 4491.25894227452, 4508.368828364031, 4516.803047192497, 4535.433070866142, 5178.17149256121, 5223.73881305937, 5235.58115350771, 5269.235960785664, 5274.498922602346, 3776.7167462440425, 3784.924301513954, 3798.5812768508563, 3799.22115966229, 3836.731428799957, 5385.380681221632, 5461.563074953994, 5495.587830912657, 5502.9174562381195, 5526.751296191681, 3894.90262743428, 3904.2581909437117, 3912.689249101526, 3924.6664033556895, 3927.273454410943, 3956.287868183697, 3963.8612648557164, 3970.622790834866, 3978.562358140602, 3981.761094334291, 4455.287154055336, 4479.104179164115, 4485.686001979895, 4493.505714371417, 4496.617787488035, 5110.131277682803, 5194.636375453758, 5200.297959775382, 5200.843974680765, 5210.505002024802, 1432.6275168456277, 1443.0836418874092, 1452.7893455449112, 1454.163855782929, 1454.8908831837655, 917.8384903552172, 963.1668606655193, 998.14159822554, 1000.474750755859, 1005.190821388789, 4590.150822097922, 4703.85888423341, 4725.669203155746, 4736.0, 4738.691985020962, 5463.426340234298, 5470.288862447856, 5489.149181876815, 5491.780328786884, 5522.144067669517, 4562.977185114053, 4634.046478588414, 4695.460022097434, 4700.694454860423, 4711.717296962193, 3112.9533057004164, 3124.7968882022597, 3126.796758210709, 3133.8433078345993, 3155.0534839548045, 5415.1335786274, 5460.945390546044, 5477.698726570077, 5479.397266300703, 5499.202615620713, 5755.568332375088, 5915.881682366328, 5946.940530594725, 6004.909926351108, 6009.609375390585, 5425.972870135624, 5445.809396671098, 5462.317210348707, 5478.315210598676, 5495.587830912617, 5640.971795140998, 5817.272840894888, 5822.7670893163795, 5830.62100963436, 5856.150858125633, 5701.771929122954, 5715.714214289352, 5725.770969161187, 5742.942570574241, 5749.482546570662, 5444.482774136451, 5466.234727138124, 5495.450454954473, 5502.862428439161, 5504.4770746778995, 3988.481497405319, 4011.939820902747, 4055.858044968412, 4061.3095773717946, 4065.9796701016307, 5742.138679198154, 5816.883662326814, 5828.125781132864, 5831.475167234969, 5849.0, 5589.217509548585, 5604.2154098425435, 5640.54875609942, 5643.238162847963, 5655.886882262414, 5427.3215848019, 5599.440055994368, 5635.126555383922, 5643.238162847963, 5659.717014149359, 5526.198701188225, 5544.667319960815, 5547.778088876561, 5571.0, 5574.442555744556, 5007.424146223231, 5028.773705183203, 5251.159814429673, 5259.948620038264, 5285.735713214401, 5147.6911385317, 5160.509751573594, 5164.586833053271, 5166.8966620668125, 5169.224616307584], "value": 4088.906893078924, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [643.5012865029602, 714.4248879651878, 719.7480881691408, 787.4645241235961, 800.2077942836594, 10888.40113793742, 10895.400752958574, 10958.12335013199, 10982.682078150634, 11973.880261197386, 11722.472488738005, 11998.520059197643, 12117.151799374047, 12135.0, 12220.266783992967, 786.5202226641744, 808.1554775259867, 808.4421748993176, 808.486611002015, 809.352517985612, 636.0903907412398, 788.1251810490351, 804.1757198871145, 814.0150417994234, 821.9589020548979, 848.2365870716374, 850.4472093139447, 857.6569372251118, 857.8412993596173, 858.2018722587991, 847.2290215903498, 852.7782776478099, 852.7868032991752, 852.8336974290016, 853.8932633420823, 620.6555361774214, 626.3517259636254, 626.8464226264595, 627.4697880291146, 628.3936001758279, 11897.583584574499, 11901.404929753478, 11916.761664766744, 11925.880741192565, 11942.223755455954, 12156.149069565046, 12260.570880019157, 12485.93757031218, 12599.811002834966, 12640.304783236918, 9485.498609455673, 9598.42409455435, 9620.90379096214, 9758.072983066597, 9845.0, 3283.063395884462, 3314.6022477302636, 3315.5689760331243, 3329.88345407912, 3407.522946787452, 43006.56993430057, 43106.13787724228, 43120.78439607782, 43311.0, 44310.11379772386, 9420.858687119699, 9667.516624168904, 9761.267904907161, 10200.132988695896, 10233.9488302558, 16847.410340638264, 16905.070221137954, 16976.74534881978, 17075.658486830194, 17091.914540427468, 6378.425941665272, 6655.933440665628, 6665.866682666319, 6782.948642960349, 6806.863862722717, 3531.94702079469, 3551.9644803551632, 3557.786532807988, 3577.0, 3615.1504396466808, 2766.5988431677292, 2816.2396153038567, 2817.492851286788, 2820.858957052139, 2824.943501130007, 487.6318379623362, 502.00352300683113, 502.90444815484943, 504.7123139810273, 509.1573445946964, 557.7183522321202, 570.5806232419169, 571.3087164530881, 595.7438301530384, 610.8930937085992, 7294.379977701955, 7406.852162788856, 7417.888731669029, 7535.171131175566, 7624.0, 481.4920259126585, 527.5542166868989, 555.7221389305347, 569.9544036477072, 570.4409678515078, 3667.8166091695307, 3764.8682296119505, 3794.9810250948567, 3809.2191100824266, 3887.4168874669026, 51148.0, 56049.0, 56383.0, 56392.0, 56444.43555564474, 41907.0, 44692.77653611711, 45273.77363113163, 47596.5240347599, 48623.0, 43331.78334108373, 44212.0, 44354.0, 44844.55155448469, 44968.0, 7547.660355283915, 7754.806129846799, 7796.220377962159, 7893.605319733875, 7955.164707705839, 29495.26261843471, 29507.704922951354, 29711.85144074266, 30038.0, 30213.395732085675, 36598.817005915866, 38365.424518632804, 38859.805700971316, 38946.80526597349, 39752.60247397489, 10002.29983901149, 10038.19694424459, 10129.392236465836, 10154.644587439405, 10206.336588121749, 10806.297590656583, 10833.404162771123, 10933.781324373627, 11469.81692849465, 11757.059435244988, 9814.0, 10199.28604997643, 10287.84568231462, 10509.474526273809, 10692.786144277226, 10541.4729263535, 10598.470076496298, 10681.946590266998, 10789.62236321725, 10840.620578280037, 9547.140757331874, 9780.706578802647, 9850.359726617748, 10100.343477673927, 10440.112590429899, 8953.104689531256, 9008.234300084305, 9034.593443295198, 9095.090490950852, 9249.263617469867, 7698.461107722405, 7987.440879138637, 8050.597470126588, 8097.554634495159, 8212.548309842778], "value": 5773.922673661001, "unit": "score"}], "name": "dromaeo_css", "value": 6317.7185456382995, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 107.0, 115.0, 117.0, 114.0, 128.0, 116.0, 114.0, 114.0, 113.0], "value": 115.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 136.0, 152.0, 190.0, 134.0, 165.0, 170.0, 132.0, 188.0, 132.0], "value": 156.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 166.0, 174.0, 164.0, 163.0, 163.0, 164.0, 165.0, 164.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 78.0, 157.0, 79.0, 75.0, 75.0, 74.0, 155.0, 75.0], "value": 91.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 146.0, 94.0, 93.0, 95.0, 149.0, 94.0, 95.0, 136.0], "value": 109.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 117.0, 119.0, 117.0, 118.0, 117.0, 118.0, 118.0, 119.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 151.0, 147.0, 149.0, 146.0, 147.0, 147.0, 148.0, 148.0, 147.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 97.0, 96.0, 95.0, 96.0, 98.0, 95.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 72.0, 67.0, 67.0, 68.0, 67.0, 67.0, 67.0, 67.0], "value": 67.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 64.0, 65.0, 64.0, 65.0, 65.0, 64.0, 70.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 79.0, 79.0, 79.0, 79.0, 80.0, 80.0, 107.0, 79.0], "value": 82.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 138.0, 132.0, 131.0, 138.0, 129.0, 129.0, 131.0, 146.0, 133.0], "value": 134.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 176.0, 176.0, 179.0, 176.0, 181.0, 172.0, 177.0, 184.0, 188.0], "value": 179.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 74.0, 74.0, 74.0, 71.0, 73.0, 73.0, 77.0, 73.0], "value": 73.8, "unit": "score"}], "name": "kraken", "value": 1600.5999999999997, "alertThreshold": 2.0}]} 07:22:28 INFO - Return code: 0 07:22:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:22:28 ERROR - # TBPL SUCCESS # 07:22:28 INFO - Running post-action listener: _resource_record_post_action 07:22:28 INFO - Running post-run listener: _resource_record_post_run 07:22:29 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 0; Write bytes: 528949248; Read time: 0; Write time: 691704 07:22:29 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 243326976; Read time: 0; Write time: 433520 07:22:29 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 285622272; Read time: 0; Write time: 258184 07:22:29 INFO - Running post-run listener: _upload_blobber_files 07:22:29 INFO - Blob upload gear active. 07:22:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:22:29 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:22:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:22:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:22:29 INFO - (blobuploader) - INFO - Open directory for files ... 07:22:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:22:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:22:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:22:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:22:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:22:30 INFO - (blobuploader) - INFO - Done attempting. 07:22:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:22:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:22:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:22:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:22:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:22:32 INFO - (blobuploader) - INFO - Done attempting. 07:22:32 INFO - (blobuploader) - INFO - Iteration through files over. 07:22:32 INFO - Return code: 0 07:22:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:22:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:22:32 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/47a211023183ae3dd43ca649352fef272e17012fc2beba7b742caff2720fcc1597e71efe537357032d68206f071b3358577160f7aa4843622823ff161a443d37", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/18ad658c6017ba4fa1a04e4f293bf9e0fe7fc70b6b68391a4b7746d481b2275fdef3a1e9486f4c51bff108b18e3d698fad44a7157258d41c19464049de069ac6"} 07:22:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:22:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:22:32 INFO - Contents: 07:22:32 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/47a211023183ae3dd43ca649352fef272e17012fc2beba7b742caff2720fcc1597e71efe537357032d68206f071b3358577160f7aa4843622823ff161a443d37", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/18ad658c6017ba4fa1a04e4f293bf9e0fe7fc70b6b68391a4b7746d481b2275fdef3a1e9486f4c51bff108b18e3d698fad44a7157258d41c19464049de069ac6"} 07:22:32 INFO - Running post-run listener: copy_logs_to_upload_dir 07:22:32 INFO - Copying logs to upload dir... 07:22:32 INFO - mkdir: /builds/slave/test/build/upload/logs 07:22:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.192496 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-04-25 07:22:31.897998) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 07:22:31.901122) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1461592915.310445-2046670663 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/47a211023183ae3dd43ca649352fef272e17012fc2beba7b742caff2720fcc1597e71efe537357032d68206f071b3358577160f7aa4843622823ff161a443d37", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/18ad658c6017ba4fa1a04e4f293bf9e0fe7fc70b6b68391a4b7746d481b2275fdef3a1e9486f4c51bff108b18e3d698fad44a7157258d41c19464049de069ac6"} build_url:https://queue.taskcluster.net/v1/task/OMTqYplySRKqVp28AOG53Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011379 build_url: 'https://queue.taskcluster.net/v1/task/OMTqYplySRKqVp28AOG53Q/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/47a211023183ae3dd43ca649352fef272e17012fc2beba7b742caff2720fcc1597e71efe537357032d68206f071b3358577160f7aa4843622823ff161a443d37", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/18ad658c6017ba4fa1a04e4f293bf9e0fe7fc70b6b68391a4b7746d481b2275fdef3a1e9486f4c51bff108b18e3d698fad44a7157258d41c19464049de069ac6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 07:22:31.926207) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 07:22:31.926599) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1461592915.310445-2046670663 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004504 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 07:22:32.010784) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 07:22:32.011093) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 07:22:32.011435) ========= ========= Total master_lag: 0.22 =========