builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-028 starttime: 1465570281.84 results: success (0) buildid: 20160610063531 builduid: a4f9a30e1520425fbd3cc723fc6675fa revision: 19adf64effcd09ebf918daa318896135c9c4d652 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-10 07:51:21.837120) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-10 07:51:21.837532) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-10 07:51:21.837803) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-10 07:51:21.901949) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 07:51:21.902290) ========= 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=836cfdc75598d54cb747368e000001a9-1465569635.883320-28414491 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-10 07:51:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-06-10 07:51:22 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.230092 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 07:51:22.148200) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 07:51:22.148598) ========= 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=836cfdc75598d54cb747368e000001a9-1465569635.883320-28414491 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020193 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 07:51:22.200050) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 07:51:22.200411) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 19adf64effcd09ebf918daa318896135c9c4d652 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 19adf64effcd09ebf918daa318896135c9c4d652 --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=836cfdc75598d54cb747368e000001a9-1465569635.883320-28414491 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-10 07:51:22,949 truncating revision to first 12 chars 2016-06-10 07:51:22,949 Setting DEBUG logging. 2016-06-10 07:51:22,949 attempt 1/10 2016-06-10 07:51:22,949 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/19adf64effcd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-10 07:51:23,266 unpacking tar archive at: mozilla-central-19adf64effcd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.678447 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 07:51:22.894185) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-10 07:51:22.894474) ========= script_repo_revision: 19adf64effcd09ebf918daa318896135c9c4d652 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-10 07:51:22.895231) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-10 07:51:22.895806) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-10 07:51:22.906095) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-06-10 07:51:22.906365) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=836cfdc75598d54cb747368e000001a9-1465569635.883320-28414491 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:51:23 INFO - MultiFileLogger online at 20160610 07:51:23 in /builds/slave/test 07:51:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 07:51:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:51:23 INFO - {'append_to_log': False, 07:51:23 INFO - 'base_work_dir': '/builds/slave/test', 07:51:23 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:51:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:51:23 INFO - 'branch': 'Firefox-Non-PGO', 07:51:23 INFO - 'buildbot_json_path': 'buildprops.json', 07:51:23 INFO - 'config_files': ('talos/linux_config.py',), 07:51:23 INFO - 'default_actions': ('clobber', 07:51:23 INFO - 'read-buildbot-config', 07:51:23 INFO - 'download-and-extract', 07:51:23 INFO - 'populate-webroot', 07:51:23 INFO - 'create-virtualenv', 07:51:23 INFO - 'install', 07:51:23 INFO - 'run-tests'), 07:51:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:51:23 INFO - 'download_minidump_stackwalk': True, 07:51:23 INFO - 'download_symbols': 'ondemand', 07:51:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:51:23 INFO - 'tooltool.py': '/tools/tooltool.py', 07:51:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:51:23 INFO - '/tools/misc-python/virtualenv.py')}, 07:51:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:51:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:51:23 INFO - 'installer_path': 'installer.exe', 07:51:23 INFO - 'log_level': 'info', 07:51:23 INFO - 'log_name': 'talos', 07:51:23 INFO - 'log_to_console': True, 07:51:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:51:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:51:23 INFO - 'opt_config_files': (), 07:51:23 INFO - 'pip_index': False, 07:51:23 INFO - 'sps_profile': False, 07:51:23 INFO - 'sps_profile_interval': 0, 07:51:23 INFO - 'suite': 'dromaeojs', 07:51:23 INFO - 'system_bits': '32', 07:51:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:51:23 INFO - 'title': 'talos-linux64-ix-028', 07:51:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:51:23 INFO - 'use_talos_json': True, 07:51:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:51:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:51:23 INFO - 'work_dir': 'build'} 07:51:23 INFO - ##### 07:51:23 INFO - ##### Running clobber step. 07:51:23 INFO - ##### 07:51:23 INFO - Running pre-action listener: _resource_record_pre_action 07:51:23 INFO - Running main action method: clobber 07:51:23 INFO - rmtree: /builds/slave/test/build 07:51:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:51:24 INFO - Running post-action listener: _resource_record_post_action 07:51:24 INFO - ##### 07:51:24 INFO - ##### Finished clobber step (success) 07:51:24 INFO - ##### 07:51:24 INFO - ##### 07:51:24 INFO - ##### Running read-buildbot-config step. 07:51:24 INFO - ##### 07:51:24 INFO - Running pre-action listener: _resource_record_pre_action 07:51:24 INFO - Running main action method: read_buildbot_config 07:51:24 INFO - Using buildbot properties: 07:51:24 INFO - { 07:51:24 INFO - "project": "", 07:51:24 INFO - "product": "firefox", 07:51:24 INFO - "script_repo_revision": "production", 07:51:24 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:51:24 INFO - "repository": "", 07:51:24 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 07:51:24 INFO - "buildid": "20160610063531", 07:51:24 INFO - "pgo_build": "False", 07:51:24 INFO - "basedir": "/builds/slave/test", 07:51:24 INFO - "buildnumber": 612, 07:51:24 INFO - "slavename": "talos-linux64-ix-028", 07:51:24 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:51:24 INFO - "platform": "ubuntu64_hw", 07:51:24 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 07:51:24 INFO - "branch": "mozilla-central", 07:51:24 INFO - "repo_path": "mozilla-central", 07:51:24 INFO - "revision": "19adf64effcd09ebf918daa318896135c9c4d652", 07:51:24 INFO - "stage_platform": "linux64", 07:51:24 INFO - "builduid": "a4f9a30e1520425fbd3cc723fc6675fa", 07:51:24 INFO - "slavebuilddir": "test" 07:51:24 INFO - } 07:51:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/PMmmz-aATJmh6QAHK85gig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:51:24 INFO - Running post-action listener: _resource_record_post_action 07:51:24 INFO - ##### 07:51:24 INFO - ##### Finished read-buildbot-config step (success) 07:51:24 INFO - ##### 07:51:24 INFO - ##### 07:51:24 INFO - ##### Running download-and-extract step. 07:51:24 INFO - ##### 07:51:24 INFO - Running pre-action listener: _resource_record_pre_action 07:51:24 INFO - Running main action method: download_and_extract 07:51:24 INFO - mkdir: /builds/slave/test/build/tests 07:51:24 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:51:24 INFO - https://queue.taskcluster.net/v1/task/PMmmz-aATJmh6QAHK85gig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:51:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PMmmz-aATJmh6QAHK85gig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:51:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PMmmz-aATJmh6QAHK85gig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:51:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PMmmz-aATJmh6QAHK85gig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:51:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PMmmz-aATJmh6QAHK85gig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:51:32 INFO - Downloaded 1361 bytes. 07:51:32 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:51:32 INFO - Using the following test package requirements: 07:51:32 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:51:32 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:51:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:51:32 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:51:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:51:32 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:51:32 INFO - u'jsshell-linux-x86_64.zip'], 07:51:32 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:51:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:51:32 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:51:32 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:51:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:51:32 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:51:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:51:32 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:51:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:51:32 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:51:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:51:32 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:51:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:51:32 INFO - https://queue.taskcluster.net/v1/task/PMmmz-aATJmh6QAHK85gig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:51:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PMmmz-aATJmh6QAHK85gig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:51:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PMmmz-aATJmh6QAHK85gig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:51:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PMmmz-aATJmh6QAHK85gig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:51:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PMmmz-aATJmh6QAHK85gig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:51:38 INFO - Downloaded 22879596 bytes. 07:51:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:51:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:51:39 INFO - Return code: 0 07:51:39 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:51:39 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:51:39 INFO - https://queue.taskcluster.net/v1/task/PMmmz-aATJmh6QAHK85gig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:51:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PMmmz-aATJmh6QAHK85gig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:51:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PMmmz-aATJmh6QAHK85gig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:51:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PMmmz-aATJmh6QAHK85gig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:51:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PMmmz-aATJmh6QAHK85gig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:51:41 INFO - Downloaded 22879596 bytes. 07:51:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:51:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:51:43 INFO - Return code: 0 07:51:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:51:43 INFO - https://queue.taskcluster.net/v1/task/PMmmz-aATJmh6QAHK85gig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:51:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PMmmz-aATJmh6QAHK85gig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:51:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PMmmz-aATJmh6QAHK85gig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:51:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PMmmz-aATJmh6QAHK85gig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:51:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PMmmz-aATJmh6QAHK85gig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:51:44 INFO - Downloaded 10833377 bytes. 07:51:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:51:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:51:44 INFO - Return code: 0 07:51:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:51:44 INFO - https://queue.taskcluster.net/v1/task/PMmmz-aATJmh6QAHK85gig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:51:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PMmmz-aATJmh6QAHK85gig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:51:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PMmmz-aATJmh6QAHK85gig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:51:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PMmmz-aATJmh6QAHK85gig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:51:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PMmmz-aATJmh6QAHK85gig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:51:45 INFO - Downloaded 55381529 bytes. 07:51:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PMmmz-aATJmh6QAHK85gig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:51:45 INFO - mkdir: /builds/slave/test/properties 07:51:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:51:45 INFO - Writing to file /builds/slave/test/properties/build_url 07:51:45 INFO - Contents: 07:51:45 INFO - build_url:https://queue.taskcluster.net/v1/task/PMmmz-aATJmh6QAHK85gig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:51:46 INFO - Running post-action listener: _resource_record_post_action 07:51:46 INFO - Running post-action listener: set_extra_try_arguments 07:51:46 INFO - ##### 07:51:46 INFO - ##### Finished download-and-extract step (success) 07:51:46 INFO - ##### 07:51:46 INFO - ##### 07:51:46 INFO - ##### Running populate-webroot step. 07:51:46 INFO - ##### 07:51:46 INFO - Running pre-action listener: _resource_record_pre_action 07:51:46 INFO - Running main action method: populate_webroot 07:51:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:51:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:51:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:51:46 INFO - '--tppagecycles', 07:51:46 INFO - '7'], 07:51:46 INFO - 'tests': ['tsvgm']}}, 07:51:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:51:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:51:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:51:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:51:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:51:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:51:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:51:46 INFO - 'talos_options': ['--disable-e10s'], 07:51:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:51:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:51:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:51:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:51:46 INFO - 'talos_options': ['--disable-e10s'], 07:51:46 INFO - 'tests': ['damp', 'tps']}, 07:51:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:51:46 INFO - 'tests': ['damp', 'tps']}, 07:51:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:51:46 INFO - 'tests': ['dromaeo_dom']}, 07:51:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:51:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:51:46 INFO - 'tests': ['a11yr', 07:51:46 INFO - 'ts_paint', 07:51:46 INFO - 'tpaint', 07:51:46 INFO - 'sessionrestore', 07:51:46 INFO - 'sessionrestore_no_auto_restore', 07:51:46 INFO - 'tabpaint']}, 07:51:46 INFO - 'other-e10s': {'tests': ['a11yr', 07:51:46 INFO - 'ts_paint', 07:51:46 INFO - 'tpaint', 07:51:46 INFO - 'sessionrestore', 07:51:46 INFO - 'sessionrestore_no_auto_restore', 07:51:46 INFO - 'tabpaint']}, 07:51:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:51:46 INFO - 'ts_paint', 07:51:46 INFO - 'tpaint', 07:51:46 INFO - 'sessionrestore', 07:51:46 INFO - 'sessionrestore_no_auto_restore', 07:51:46 INFO - 'tabpaint']}, 07:51:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:51:46 INFO - 'ts_paint', 07:51:46 INFO - 'tpaint', 07:51:46 INFO - 'sessionrestore', 07:51:46 INFO - 'sessionrestore_no_auto_restore', 07:51:46 INFO - 'tabpaint']}, 07:51:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:51:46 INFO - 'tests': ['a11yr', 07:51:46 INFO - 'ts_paint', 07:51:46 INFO - 'tpaint', 07:51:46 INFO - 'sessionrestore', 07:51:46 INFO - 'sessionrestore_no_auto_restore', 07:51:46 INFO - 'tabpaint']}, 07:51:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:51:46 INFO - 'tests': ['a11yr', 07:51:46 INFO - 'ts_paint', 07:51:46 INFO - 'tpaint', 07:51:46 INFO - 'sessionrestore', 07:51:46 INFO - 'sessionrestore_no_auto_restore', 07:51:46 INFO - 'tabpaint']}, 07:51:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:51:46 INFO - 'tests': ['tsvgx', 07:51:46 INFO - 'tsvgr_opacity', 07:51:46 INFO - 'tart', 07:51:46 INFO - 'tscrollx', 07:51:46 INFO - 'cart']}, 07:51:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:51:46 INFO - 'tsvgr_opacity', 07:51:46 INFO - 'tart', 07:51:46 INFO - 'tscrollx', 07:51:46 INFO - 'cart']}, 07:51:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:51:46 INFO - 'talos_options': ['--disable-e10s'], 07:51:46 INFO - 'tests': ['tp5o']}, 07:51:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:51:46 INFO - 'tests': ['tp5o']}, 07:51:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:51:46 INFO - 'talos_options': ['--disable-e10s', 07:51:46 INFO - '--xperf_path', 07:51:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:51:46 INFO - 'tests': ['tp5n']}, 07:51:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:51:46 INFO - 'talos_options': ['--xperf_path', 07:51:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:51:46 INFO - 'tests': ['tp5n']}}, 07:51:46 INFO - 'talos.zip': {'path': '', 07:51:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:51:46 INFO - Running post-action listener: _resource_record_post_action 07:51:46 INFO - ##### 07:51:46 INFO - ##### Finished populate-webroot step (success) 07:51:46 INFO - ##### 07:51:46 INFO - ##### 07:51:46 INFO - ##### Running create-virtualenv step. 07:51:46 INFO - ##### 07:51:46 INFO - Running pre-action listener: _resource_record_pre_action 07:51:46 INFO - Running main action method: create_virtualenv 07:51:46 INFO - Creating virtualenv /builds/slave/test/build/venv 07:51:46 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:51:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:51:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:51:46 INFO - Using real prefix '/usr' 07:51:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:51:47 INFO - Installing distribute.............................................................................................................................................................................................done. 07:51:49 INFO - Installing pip.................done. 07:51:49 INFO - Return code: 0 07:51:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:51:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:51:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:51:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:51:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:49 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 0x7fda4bacbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff82e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff2e20>, '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 0x1ff63a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff6830>, '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': '836cfdc75598d54cb747368e000001a9-1465569635.883320-28414491', '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:51:49 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:51:49 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:51:49 INFO - Using env: {'DISPLAY': ':0', 07:51:49 INFO - 'HOME': '/home/cltbld', 07:51:49 INFO - 'LANG': 'en_US.UTF-8', 07:51:49 INFO - 'LANGUAGE': 'en_US:en', 07:51:49 INFO - 'LOGNAME': 'cltbld', 07:51:49 INFO - 'MAIL': '/var/mail/cltbld', 07:51:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:51:49 INFO - 'MOZ_NO_REMOTE': '1', 07:51:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:51:49 INFO - 'NO_EM_RESTART': '1', 07:51:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:51:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:51:49 INFO - 'PWD': '/builds/slave/test', 07:51:49 INFO - 'SHELL': '/bin/bash', 07:51:49 INFO - 'SHLVL': '1', 07:51:49 INFO - 'TERM': 'linux', 07:51:49 INFO - 'TMOUT': '86400', 07:51:49 INFO - 'USER': 'cltbld', 07:51:49 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465569635.883320-28414491', 07:51:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:51:49 INFO - '_': '/tools/buildbot/bin/python'} 07:51:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:51:49 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:51:49 INFO - Cleaning up... 07:51:49 INFO - Return code: 0 07:51:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:51:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:51:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:51:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:51:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:49 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda4bacbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff82e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff2e20>, '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 0x1ff63a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff6830>, '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': '836cfdc75598d54cb747368e000001a9-1465569635.883320-28414491', '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:51:49 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>=3.1.1'] in /builds/slave/test/build 07:51:49 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>=3.1.1 07:51:49 INFO - Using env: {'DISPLAY': ':0', 07:51:49 INFO - 'HOME': '/home/cltbld', 07:51:49 INFO - 'LANG': 'en_US.UTF-8', 07:51:49 INFO - 'LANGUAGE': 'en_US:en', 07:51:49 INFO - 'LOGNAME': 'cltbld', 07:51:49 INFO - 'MAIL': '/var/mail/cltbld', 07:51:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:51:49 INFO - 'MOZ_NO_REMOTE': '1', 07:51:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:51:49 INFO - 'NO_EM_RESTART': '1', 07:51:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:51:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:51:49 INFO - 'PWD': '/builds/slave/test', 07:51:49 INFO - 'SHELL': '/bin/bash', 07:51:49 INFO - 'SHLVL': '1', 07:51:49 INFO - 'TERM': 'linux', 07:51:49 INFO - 'TMOUT': '86400', 07:51:49 INFO - 'USER': 'cltbld', 07:51:49 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465569635.883320-28414491', 07:51:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:51:49 INFO - '_': '/tools/buildbot/bin/python'} 07:51:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:51:49 INFO - Downloading/unpacking psutil>=3.1.1 07:51:49 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:51:49 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:51:49 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:51:49 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:51:49 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:51:49 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:51:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:51:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:51:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:51:51 INFO - Installing collected packages: psutil 07:51:51 INFO - Running setup.py install for psutil 07:51:51 INFO - building 'psutil._psutil_linux' extension 07:51:51 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:51:51 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:51:51 INFO - building 'psutil._psutil_posix' extension 07:51:51 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:51:52 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:51:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:51:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:51:52 INFO - Successfully installed psutil 07:51:52 INFO - Cleaning up... 07:51:52 INFO - Return code: 0 07:51:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:51:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:51:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:51:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:51:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:51:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:52 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda4bacbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff82e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff2e20>, '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 0x1ff63a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff6830>, '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': '836cfdc75598d54cb747368e000001a9-1465569635.883320-28414491', '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:51:52 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.3'] in /builds/slave/test/build 07:51:52 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.3 07:51:52 INFO - Using env: {'DISPLAY': ':0', 07:51:52 INFO - 'HOME': '/home/cltbld', 07:51:52 INFO - 'LANG': 'en_US.UTF-8', 07:51:52 INFO - 'LANGUAGE': 'en_US:en', 07:51:52 INFO - 'LOGNAME': 'cltbld', 07:51:52 INFO - 'MAIL': '/var/mail/cltbld', 07:51:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:51:52 INFO - 'MOZ_NO_REMOTE': '1', 07:51:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:51:52 INFO - 'NO_EM_RESTART': '1', 07:51:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:51:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:51:52 INFO - 'PWD': '/builds/slave/test', 07:51:52 INFO - 'SHELL': '/bin/bash', 07:51:52 INFO - 'SHLVL': '1', 07:51:52 INFO - 'TERM': 'linux', 07:51:52 INFO - 'TMOUT': '86400', 07:51:52 INFO - 'USER': 'cltbld', 07:51:52 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465569635.883320-28414491', 07:51:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:51:52 INFO - '_': '/tools/buildbot/bin/python'} 07:51:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:51:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:51:52 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:51:52 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:51:52 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:51:52 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:51:52 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:51:52 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:51:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:51:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:51:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:51:54 INFO - Installing collected packages: mozsystemmonitor 07:51:54 INFO - Running setup.py install for mozsystemmonitor 07:51:54 INFO - Successfully installed mozsystemmonitor 07:51:54 INFO - Cleaning up... 07:51:54 INFO - Return code: 0 07:51:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:51:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:51:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:51:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:51:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:51:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:54 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda4bacbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff82e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff2e20>, '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 0x1ff63a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff6830>, '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': '836cfdc75598d54cb747368e000001a9-1465569635.883320-28414491', '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:51:54 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==2.5.1'] in /builds/slave/test/build 07:51:54 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==2.5.1 07:51:54 INFO - Using env: {'DISPLAY': ':0', 07:51:54 INFO - 'HOME': '/home/cltbld', 07:51:54 INFO - 'LANG': 'en_US.UTF-8', 07:51:54 INFO - 'LANGUAGE': 'en_US:en', 07:51:54 INFO - 'LOGNAME': 'cltbld', 07:51:54 INFO - 'MAIL': '/var/mail/cltbld', 07:51:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:51:54 INFO - 'MOZ_NO_REMOTE': '1', 07:51:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:51:54 INFO - 'NO_EM_RESTART': '1', 07:51:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:51:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:51:54 INFO - 'PWD': '/builds/slave/test', 07:51:54 INFO - 'SHELL': '/bin/bash', 07:51:54 INFO - 'SHLVL': '1', 07:51:54 INFO - 'TERM': 'linux', 07:51:54 INFO - 'TMOUT': '86400', 07:51:54 INFO - 'USER': 'cltbld', 07:51:54 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465569635.883320-28414491', 07:51:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:51:54 INFO - '_': '/tools/buildbot/bin/python'} 07:51:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:51:54 INFO - Downloading/unpacking jsonschema==2.5.1 07:51:54 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:51:54 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:51:54 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:51:54 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:51:54 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:51:54 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:51:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:51:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:51:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:51:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:51:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:51:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:51:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:51:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:51:57 INFO - Downloading functools32-3.2.3-2.tar.gz 07:51:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:51:57 INFO - warning: no files found matching '*.txt' 07:51:57 INFO - no previously-included directories found matching 'build' 07:51:57 INFO - no previously-included directories found matching 'dist' 07:51:57 INFO - no previously-included directories found matching '.git*' 07:51:57 INFO - Installing collected packages: jsonschema, functools32 07:51:57 INFO - Running setup.py install for functools32 07:51:58 INFO - warning: no files found matching '*.txt' 07:51:58 INFO - no previously-included directories found matching 'build' 07:51:58 INFO - no previously-included directories found matching 'dist' 07:51:58 INFO - no previously-included directories found matching '.git*' 07:51:58 INFO - Successfully installed jsonschema functools32 07:51:58 INFO - Cleaning up... 07:51:58 INFO - Return code: 0 07:51:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:51: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:51:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:51:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51: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:51:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:51:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:51:58 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 0x7fda4bacbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff82e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff2e20>, '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 0x1ff63a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff6830>, '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': '836cfdc75598d54cb747368e000001a9-1465569635.883320-28414491', '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:51:58 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:51:58 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:51:58 INFO - Using env: {'DISPLAY': ':0', 07:51:58 INFO - 'HOME': '/home/cltbld', 07:51:58 INFO - 'LANG': 'en_US.UTF-8', 07:51:58 INFO - 'LANGUAGE': 'en_US:en', 07:51:58 INFO - 'LOGNAME': 'cltbld', 07:51:58 INFO - 'MAIL': '/var/mail/cltbld', 07:51:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:51:58 INFO - 'MOZ_NO_REMOTE': '1', 07:51:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:51:58 INFO - 'NO_EM_RESTART': '1', 07:51:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:51:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:51:58 INFO - 'PWD': '/builds/slave/test', 07:51:58 INFO - 'SHELL': '/bin/bash', 07:51:58 INFO - 'SHLVL': '1', 07:51:58 INFO - 'TERM': 'linux', 07:51:58 INFO - 'TMOUT': '86400', 07:51:58 INFO - 'USER': 'cltbld', 07:51:58 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465569635.883320-28414491', 07:51:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:51:58 INFO - '_': '/tools/buildbot/bin/python'} 07:51:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:51:58 INFO - Downloading/unpacking blobuploader==1.2.4 07:51:58 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:51:58 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:51:58 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:51:58 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:51:58 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:51:58 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:52:00 INFO - Downloading blobuploader-1.2.4.tar.gz 07:52:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:52:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:52:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:52:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:52:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:00 INFO - Downloading docopt-0.6.1.tar.gz 07:52:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:52:00 INFO - Installing collected packages: blobuploader, requests, docopt 07:52:00 INFO - Running setup.py install for blobuploader 07:52:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:52:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:52:01 INFO - Running setup.py install for requests 07:52:01 INFO - Running setup.py install for docopt 07:52:01 INFO - Successfully installed blobuploader requests docopt 07:52:01 INFO - Cleaning up... 07:52:01 INFO - Return code: 0 07:52:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:52: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:52:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52: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:52:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:01 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 0x7fda4bacbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff82e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff2e20>, '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 0x1ff63a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff6830>, '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': '836cfdc75598d54cb747368e000001a9-1465569635.883320-28414491', '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:52:01 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:52:01 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:52:01 INFO - Using env: {'DISPLAY': ':0', 07:52:01 INFO - 'HOME': '/home/cltbld', 07:52:01 INFO - 'LANG': 'en_US.UTF-8', 07:52:01 INFO - 'LANGUAGE': 'en_US:en', 07:52:01 INFO - 'LOGNAME': 'cltbld', 07:52:01 INFO - 'MAIL': '/var/mail/cltbld', 07:52:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:01 INFO - 'MOZ_NO_REMOTE': '1', 07:52:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:01 INFO - 'NO_EM_RESTART': '1', 07:52:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:01 INFO - 'PWD': '/builds/slave/test', 07:52:01 INFO - 'SHELL': '/bin/bash', 07:52:01 INFO - 'SHLVL': '1', 07:52:01 INFO - 'TERM': 'linux', 07:52:01 INFO - 'TMOUT': '86400', 07:52:01 INFO - 'USER': 'cltbld', 07:52:01 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465569635.883320-28414491', 07:52:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:01 INFO - '_': '/tools/buildbot/bin/python'} 07:52:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:52:01 INFO - Running setup.py (path:/tmp/pip-AvDCvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:52:01 INFO - Running setup.py (path:/tmp/pip-saddm9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:52:01 INFO - Running setup.py (path:/tmp/pip-z97idL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:52:01 INFO - Running setup.py (path:/tmp/pip-NEvnQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:52:02 INFO - Running setup.py (path:/tmp/pip-Fz0neb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:52:02 INFO - Running setup.py (path:/tmp/pip-hjZLcT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:52:02 INFO - Running setup.py (path:/tmp/pip-ba4sdk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:52:02 INFO - Running setup.py (path:/tmp/pip-0H_1SK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:52:02 INFO - Running setup.py (path:/tmp/pip-fVCWtF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:52:02 INFO - Running setup.py (path:/tmp/pip-LikV0Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:52:02 INFO - Running setup.py (path:/tmp/pip-V1ORG4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:52:02 INFO - Running setup.py (path:/tmp/pip-NMs5do-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:52:02 INFO - Running setup.py (path:/tmp/pip-tfWTjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:52:02 INFO - Running setup.py (path:/tmp/pip-bRzzIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:52:02 INFO - Running setup.py (path:/tmp/pip-JK2Cwg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:52:02 INFO - Running setup.py (path:/tmp/pip-23b9uf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:52:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:52:02 INFO - Running setup.py (path:/tmp/pip-QKLsPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:52:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:52:03 INFO - Running setup.py install for manifestparser 07:52:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:52:03 INFO - Running setup.py install for mozcrash 07:52:03 INFO - Running setup.py install for mozdebug 07:52:03 INFO - Running setup.py install for mozdevice 07:52:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:52:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:52:03 INFO - Running setup.py install for mozfile 07:52:03 INFO - Running setup.py install for mozhttpd 07:52:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:52:03 INFO - Running setup.py install for mozinfo 07:52:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:52:03 INFO - Running setup.py install for mozInstall 07:52:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:52:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:52:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:52:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:52:03 INFO - Running setup.py install for mozleak 07:52:03 INFO - Running setup.py install for mozlog 07:52:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:52:04 INFO - Running setup.py install for moznetwork 07:52:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:52:04 INFO - Running setup.py install for mozprocess 07:52:04 INFO - Running setup.py install for mozprofile 07:52:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:52:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:52:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:52:04 INFO - Running setup.py install for mozrunner 07:52:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:52:04 INFO - Running setup.py install for mozscreenshot 07:52:04 INFO - Running setup.py install for moztest 07:52:04 INFO - Running setup.py install for mozversion 07:52:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:52:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:52:04 INFO - Cleaning up... 07:52:04 INFO - Return code: 0 07:52:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:52: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:52:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52: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:52:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:04 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 0x7fda4bacbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff82e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff2e20>, '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 0x1ff63a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff6830>, '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': '836cfdc75598d54cb747368e000001a9-1465569635.883320-28414491', '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:52:04 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:52:04 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:52:04 INFO - Using env: {'DISPLAY': ':0', 07:52:04 INFO - 'HOME': '/home/cltbld', 07:52:04 INFO - 'LANG': 'en_US.UTF-8', 07:52:04 INFO - 'LANGUAGE': 'en_US:en', 07:52:04 INFO - 'LOGNAME': 'cltbld', 07:52:04 INFO - 'MAIL': '/var/mail/cltbld', 07:52:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:04 INFO - 'MOZ_NO_REMOTE': '1', 07:52:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:04 INFO - 'NO_EM_RESTART': '1', 07:52:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:04 INFO - 'PWD': '/builds/slave/test', 07:52:04 INFO - 'SHELL': '/bin/bash', 07:52:04 INFO - 'SHLVL': '1', 07:52:04 INFO - 'TERM': 'linux', 07:52:04 INFO - 'TMOUT': '86400', 07:52:04 INFO - 'USER': 'cltbld', 07:52:04 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465569635.883320-28414491', 07:52:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:04 INFO - '_': '/tools/buildbot/bin/python'} 07:52:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:52:05 INFO - Running setup.py (path:/tmp/pip-nMwVIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:52:05 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:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:52:05 INFO - Running setup.py (path:/tmp/pip-qim6QD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:52:05 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:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:52:05 INFO - Running setup.py (path:/tmp/pip-xzNoG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:52:05 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:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:52:05 INFO - Running setup.py (path:/tmp/pip-ZLxiE8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:52:05 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:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:52:05 INFO - Running setup.py (path:/tmp/pip-7sVdl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:52:05 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:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:52:05 INFO - Running setup.py (path:/tmp/pip-tA58By-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:52:05 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:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:52:05 INFO - Running setup.py (path:/tmp/pip-JlQYWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:52:05 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:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:52:05 INFO - Running setup.py (path:/tmp/pip-DmBDbM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:52:05 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:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:52:05 INFO - Running setup.py (path:/tmp/pip-DJj4hd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:52:05 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:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:52:05 INFO - Running setup.py (path:/tmp/pip-UEeI4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:52:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:52:05 INFO - Running setup.py (path:/tmp/pip-0v6YQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:52:05 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:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:52:05 INFO - Running setup.py (path:/tmp/pip-kTkaMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:52:05 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:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:52:05 INFO - Running setup.py (path:/tmp/pip-6Fph8M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:52:05 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:52:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:52:05 INFO - Running setup.py (path:/tmp/pip-Z1aQNc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:52:06 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:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:52:06 INFO - Running setup.py (path:/tmp/pip-2FyyEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:52:06 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:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:52:06 INFO - Running setup.py (path:/tmp/pip-y9zDGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:52:06 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:52:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:52:06 INFO - Running setup.py (path:/tmp/pip-bOtTMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:52:06 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:52:06 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:52:06 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:52:06 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:52:06 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:52:06 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:52:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:52:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:52:08 INFO - Downloading blessings-1.6.tar.gz 07:52:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:52:08 INFO - Installing collected packages: blessings 07:52:08 INFO - Running setup.py install for blessings 07:52:08 INFO - Successfully installed blessings 07:52:08 INFO - Cleaning up... 07:52:08 INFO - Return code: 0 07:52:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:52:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:52:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:52:08 INFO - Reading from file tmpfile_stdout 07:52:08 INFO - Current package versions: 07:52:08 INFO - argparse == 1.2.1 07:52:08 INFO - blessings == 1.6 07:52:08 INFO - blobuploader == 1.2.4 07:52:08 INFO - docopt == 0.6.1 07:52:08 INFO - functools32 == 3.2.3-2 07:52:08 INFO - jsonschema == 2.5.1 07:52:08 INFO - manifestparser == 1.1 07:52:08 INFO - mozInstall == 1.12 07:52:08 INFO - mozcrash == 0.17 07:52:08 INFO - mozdebug == 0.1 07:52:08 INFO - mozdevice == 0.48 07:52:08 INFO - mozfile == 1.2 07:52:08 INFO - mozhttpd == 0.7 07:52:08 INFO - mozinfo == 0.9 07:52:08 INFO - mozleak == 0.1 07:52:08 INFO - mozlog == 3.2 07:52:08 INFO - moznetwork == 0.27 07:52:08 INFO - mozprocess == 0.22 07:52:08 INFO - mozprofile == 0.28 07:52:08 INFO - mozrunner == 6.11 07:52:08 INFO - mozscreenshot == 0.1 07:52:08 INFO - mozsystemmonitor == 0.3 07:52:08 INFO - moztest == 0.7 07:52:08 INFO - mozversion == 1.4 07:52:08 INFO - psutil == 3.1.1 07:52:08 INFO - requests == 1.2.3 07:52:08 INFO - wsgiref == 0.1.2 07:52:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:52:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:52:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:52:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:08 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 0x7fda4bacbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff82e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff2e20>, '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 0x1ff63a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff6830>, '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': '836cfdc75598d54cb747368e000001a9-1465569635.883320-28414491', '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:52:08 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:52:08 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:52:08 INFO - Using env: {'DISPLAY': ':0', 07:52:08 INFO - 'HOME': '/home/cltbld', 07:52:08 INFO - 'LANG': 'en_US.UTF-8', 07:52:08 INFO - 'LANGUAGE': 'en_US:en', 07:52:08 INFO - 'LOGNAME': 'cltbld', 07:52:08 INFO - 'MAIL': '/var/mail/cltbld', 07:52:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:08 INFO - 'MOZ_NO_REMOTE': '1', 07:52:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:08 INFO - 'NO_EM_RESTART': '1', 07:52:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:08 INFO - 'PWD': '/builds/slave/test', 07:52:08 INFO - 'SHELL': '/bin/bash', 07:52:08 INFO - 'SHLVL': '1', 07:52:08 INFO - 'TERM': 'linux', 07:52:08 INFO - 'TMOUT': '86400', 07:52:08 INFO - 'USER': 'cltbld', 07:52:08 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465569635.883320-28414491', 07:52:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:08 INFO - '_': '/tools/buildbot/bin/python'} 07:52:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:08 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:52:08 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:52:08 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:52:08 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:52:08 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:52:08 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:52:08 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:52:08 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:52:08 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:52:08 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:52:08 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:52:08 INFO - Cleaning up... 07:52:08 INFO - Return code: 0 07:52:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:52:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:52:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:52:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:08 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 0x7fda4bacbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff82e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff2e20>, '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 0x1ff63a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff6830>, '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': '836cfdc75598d54cb747368e000001a9-1465569635.883320-28414491', '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:52:08 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:52:08 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:52:08 INFO - Using env: {'DISPLAY': ':0', 07:52:08 INFO - 'HOME': '/home/cltbld', 07:52:08 INFO - 'LANG': 'en_US.UTF-8', 07:52:08 INFO - 'LANGUAGE': 'en_US:en', 07:52:08 INFO - 'LOGNAME': 'cltbld', 07:52:08 INFO - 'MAIL': '/var/mail/cltbld', 07:52:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:08 INFO - 'MOZ_NO_REMOTE': '1', 07:52:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:08 INFO - 'NO_EM_RESTART': '1', 07:52:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:08 INFO - 'PWD': '/builds/slave/test', 07:52:08 INFO - 'SHELL': '/bin/bash', 07:52:08 INFO - 'SHLVL': '1', 07:52:08 INFO - 'TERM': 'linux', 07:52:08 INFO - 'TMOUT': '86400', 07:52:08 INFO - 'USER': 'cltbld', 07:52:08 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465569635.883320-28414491', 07:52:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:08 INFO - '_': '/tools/buildbot/bin/python'} 07:52:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:52:09 INFO - Cleaning up... 07:52:09 INFO - Return code: 0 07:52:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:52:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:52:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:52:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:52:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:52:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:52:09 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 0x7fda4bacbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff82e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff2e20>, '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 0x1ff63a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff6830>, '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': '836cfdc75598d54cb747368e000001a9-1465569635.883320-28414491', '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:52:09 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:52:09 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:52:09 INFO - Using env: {'DISPLAY': ':0', 07:52:09 INFO - 'HOME': '/home/cltbld', 07:52:09 INFO - 'LANG': 'en_US.UTF-8', 07:52:09 INFO - 'LANGUAGE': 'en_US:en', 07:52:09 INFO - 'LOGNAME': 'cltbld', 07:52:09 INFO - 'MAIL': '/var/mail/cltbld', 07:52:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:09 INFO - 'MOZ_NO_REMOTE': '1', 07:52:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:09 INFO - 'NO_EM_RESTART': '1', 07:52:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:09 INFO - 'PWD': '/builds/slave/test', 07:52:09 INFO - 'SHELL': '/bin/bash', 07:52:09 INFO - 'SHLVL': '1', 07:52:09 INFO - 'TERM': 'linux', 07:52:09 INFO - 'TMOUT': '86400', 07:52:09 INFO - 'USER': 'cltbld', 07:52:09 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465569635.883320-28414491', 07:52:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:09 INFO - '_': '/tools/buildbot/bin/python'} 07:52:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:52:09 INFO - Downloading/unpacking flake8 07:52:09 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:52:09 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:52:09 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:52:09 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:52:09 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:52:09 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:52:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:52:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:52:11 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:52:11 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:52:11 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:52:11 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:52:11 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:52:11 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:52:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:52:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:52:11 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:52:11 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:52:11 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:52:11 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:52:11 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:52:11 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:52:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:52:11 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:52:11 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:52:11 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:52:11 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:52:11 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:52:11 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:52:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:52:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:52:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:52:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:52:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:52:11 INFO - no previously-included directories found matching 'docs/_build' 07:52:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:52:11 INFO - Running setup.py install for pep8 07:52:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:52:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:52:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:52:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:52:12 INFO - no previously-included directories found matching 'docs/_build' 07:52:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:52:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:52:12 INFO - Cleaning up... 07:52:12 INFO - Return code: 0 07:52:12 INFO - Running post-action listener: _resource_record_post_action 07:52:12 INFO - Running post-action listener: _start_resource_monitoring 07:52:12 INFO - Starting resource monitoring. 07:52:12 INFO - ##### 07:52:12 INFO - ##### Finished create-virtualenv step (success) 07:52:12 INFO - ##### 07:52:12 INFO - ##### 07:52:12 INFO - ##### Running install step. 07:52:12 INFO - ##### 07:52:12 INFO - Running pre-action listener: _resource_record_pre_action 07:52:12 INFO - Running main action method: install 07:52:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:52:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:52:12 INFO - Reading from file tmpfile_stdout 07:52:12 INFO - Detecting whether we're running mozinstall >=1.0... 07:52:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:52:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:52:12 INFO - Reading from file tmpfile_stdout 07:52:12 INFO - Output received: 07:52:12 INFO - Usage: mozinstall [options] installer 07:52:12 INFO - Options: 07:52:12 INFO - -h, --help show this help message and exit 07:52:12 INFO - -d DEST, --destination=DEST 07:52:12 INFO - Directory to install application into. [default: 07:52:12 INFO - "/builds/slave/test"] 07:52:12 INFO - --app=APP Application being installed. [default: firefox] 07:52:12 INFO - mkdir: /builds/slave/test/build/application 07:52:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:52:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:52:28 INFO - Reading from file tmpfile_stdout 07:52:28 INFO - Output received: 07:52:28 INFO - /builds/slave/test/build/application/firefox/firefox 07:52:28 INFO - Running post-action listener: _resource_record_post_action 07:52:28 INFO - ##### 07:52:28 INFO - ##### Finished install step (success) 07:52:28 INFO - ##### 07:52:28 INFO - ##### 07:52:28 INFO - ##### Running run-tests step. 07:52:28 INFO - ##### 07:52:28 INFO - Running pre-action listener: _resource_record_pre_action 07:52:28 INFO - Running main action method: run_tests 07:52:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:52:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:52:28 INFO - Python 2.7.3 07:52:28 INFO - Return code: 0 07:52:28 INFO - grabbing minidump binary from tooltool 07:52: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:52:28 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff2e20>, '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 0x1ff63a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ff6830>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:52:28 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:52:28 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:52:28 INFO - Calling ['/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'] with output_timeout 600 07:52:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:52:28 INFO - Return code: 0 07:52:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:52:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:52:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:52:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:52:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:52:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:52:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:52:29 INFO - Return code: 0 07:52:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PMmmz-aATJmh6QAHK85gig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:52:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PMmmz-aATJmh6QAHK85gig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:52:29 INFO - Using env: {'DISPLAY': ':0', 07:52:29 INFO - 'HOME': '/home/cltbld', 07:52:29 INFO - 'LANG': 'en_US.UTF-8', 07:52:29 INFO - 'LANGUAGE': 'en_US:en', 07:52:29 INFO - 'LOGNAME': 'cltbld', 07:52:29 INFO - 'MAIL': '/var/mail/cltbld', 07:52:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:52:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:52:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:52:29 INFO - 'MOZ_NO_REMOTE': '1', 07:52:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:52:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:52:29 INFO - 'NO_EM_RESTART': '1', 07:52:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:52:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:52:29 INFO - 'PWD': '/builds/slave/test', 07:52:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:52:29 INFO - 'SHELL': '/bin/bash', 07:52:29 INFO - 'SHLVL': '1', 07:52:29 INFO - 'TERM': 'linux', 07:52:29 INFO - 'TMOUT': '86400', 07:52:29 INFO - 'USER': 'cltbld', 07:52:29 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465569635.883320-28414491', 07:52:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:52:29 INFO - '_': '/tools/buildbot/bin/python'} 07:52:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PMmmz-aATJmh6QAHK85gig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:52:29 INFO - mozversion application_buildid: 20160610063531 07:52:29 INFO - mozversion application_changeset: 19adf64effcd09ebf918daa318896135c9c4d652 07:52:29 INFO - mozversion application_display_name: Nightly 07:52:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:52:29 INFO - mozversion application_name: Firefox 07:52:29 INFO - mozversion application_remotingname: firefox 07:52:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:52:29 INFO - mozversion application_vendor: Mozilla 07:52:29 INFO - mozversion application_version: 50.0a1 07:52:29 INFO - mozversion platform_buildid: 20160610063531 07:52:29 INFO - mozversion platform_changeset: 19adf64effcd09ebf918daa318896135c9c4d652 07:52:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:52:29 INFO - mozversion platform_version: 50.0a1 07:52:29 INFO - using testdate: 1465570349 07:52:29 INFO - actual date: 1465570349 07:52:29 INFO - starting webserver on 'localhost:34641' 07:52:29 INFO - SUITE-START | Running 2 tests 07:52:29 INFO - TEST-START | dromaeo_css 07:52:29 INFO - operating with platform_type : linux_ 07:52:29 INFO - Initialising browser for dromaeo_css test... 07:52:29 INFO - TEST-INFO | started process 18362 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf0l56Q/profile http://localhost:34641/getInfo.html) 07:52:34 INFO - PROCESS | 18362 | __metrics Screen width/height:1600/1200 07:52:34 INFO - PROCESS | 18362 | colorDepth:24 07:52:34 INFO - PROCESS | 18362 | Browser inner width/height: 1024/697 07:52:34 INFO - PROCESS | 18362 | __metrics 07:52:35 ERROR - PROCESS | 18362 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:52:35 INFO - PROCESS | 18362 | console.error: PushService: 07:52:35 INFO - PROCESS | 18362 | stateChangeProcessEnqueue: Error transitioning state 07:52:35 INFO - PROCESS | 18362 | UnknownError 07:52:36 INFO - TEST-INFO | 18362: exit 0 07:52:36 INFO - Browser initialized. 07:52:36 INFO - Running cycle 1/1 for dromaeo_css test... 07:52:36 INFO - TEST-INFO | started process 18444 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf0l56Q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:52:48 INFO - PROCESS | 18444 | RSS: Main: 174755840 07:52:48 INFO - PROCESS | 18444 | 07:53:40 INFO - PROCESS | 18444 | 1465570420355 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:55:52 INFO - PROCESS | 18444 | Cycle 1(1): loaded http://localhost:34641/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34641/tests/dromaeo/cssquery-ext.html) 07:55:53 INFO - PROCESS | 18444 | RSS: Main: 282587136 07:55:53 INFO - PROCESS | 18444 | 07:58:56 INFO - PROCESS | 18444 | Cycle 1(1): loaded http://localhost:34641/tests/dromaeo/cssquery-ext.html (next: http://localhost:34641/tests/dromaeo/cssquery-jquery.html) 07:58:56 INFO - PROCESS | 18444 | RSS: Main: 259256320 07:58:56 INFO - PROCESS | 18444 | 08:01:58 INFO - PROCESS | 18444 | Cycle 1(1): loaded http://localhost:34641/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34641/tests/dromaeo/cssquery-mootools.html) 08:01:59 INFO - PROCESS | 18444 | RSS: Main: 266162176 08:01:59 INFO - PROCESS | 18444 | 08:05:01 INFO - PROCESS | 18444 | Cycle 1(1): loaded http://localhost:34641/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34641/tests/dromaeo/cssquery-prototype.html) 08:05:02 INFO - PROCESS | 18444 | RSS: Main: 258936832 08:05:02 INFO - PROCESS | 18444 | 08:08:05 INFO - PROCESS | 18444 | Cycle 1(1): loaded http://localhost:34641/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34641/tests/dromaeo/cssquery-yui.html) 08:08:06 INFO - PROCESS | 18444 | RSS: Main: 241025024 08:08:06 INFO - PROCESS | 18444 | 08:11:08 INFO - PROCESS | 18444 | Cycle 1(1): loaded http://localhost:34641/tests/dromaeo/cssquery-yui.html (next: http://localhost:34641/tests/dromaeo/cssquery-dojo.html) 08:11:09 INFO - PROCESS | 18444 | RSS: Main: 286875648 08:11:09 INFO - PROCESS | 18444 | 08:11:09 INFO - PROCESS | 18444 | __start_tp_report 08:11:09 INFO - PROCESS | 18444 | _x_x_mozilla_page_load 08:11:09 INFO - PROCESS | 18444 | _x_x_mozilla_page_load_details 08:11:09 INFO - PROCESS | 18444 | |i|pagename|runs| 08:11:09 INFO - PROCESS | 18444 | |0;dojo.html;2638.406358569322;2642.9867850660744;2681.5173268811614;2698.797590180736;2705.4048109415935;4596.356510088582;4680.789364478598;4777.689450185735;4859.416869975599;4879;4711.882202944928;4735.763211839403;4755.31047998041;4821.8794530136765;4845.927311090337;4401.427814384142;4413;4455.732656040632;4469.955300447003;4473.709208901411;4404.515503294635;4473.9552604473865;4516.1193567254395;4516.932246016312;4541.65937554683;4452.866414007585;4507.076049409863;4523.638108951292;4558.703684260529;4568.497465278817;4262.1049579588325;4295.742255464682;4307.8492252771;4335.328024156261;4409.140217657558;4335.024619460628;4356.215881141393;4362.629176519968;4362.650987920959;4388.561143885618;4757.429108507002;4833.637477189225;4844.8304309349005;4848.03039392123;4852.078105160008;4918.631102667314;5026.095302845486;5039.21892106724;5186.818461353834;5194.168932970744;5180.015796998596;5180.248863914711;5181.326427564431;5189.169732842727;5189.3772747270195;4800.879978000543;4810.302506136591;4828.975855120772;4832.347633069561;4833.371661684029;5040.420351659533;5131.871703207375;5163.586913046947;5190.039842629126;5226.294450249244;4981.053599816023;4998.5751211146735;5028.245763135559;5048.343715316985;5048.646594738407;5074.517920797518;5075.2387141929;5081.390233172043;5081.974590127025;5115.232715092691;4853.563179313808;5048.343715317059;5092.185250359925;5104.770285337168;5121.974390128025;5086.109930762102;5106.055379754683;5121.4878512149235;5126.077306084941;5162.045021671003;4172.666186705056;4363.432753742057;4370.628496577827;4375.518692943773;4428.535003824616;3703.6111208323277;3775.8489660413275;3780.2628487445236;3807.8667246646787;3874.1864208515963;4383.802728877208;4399.20814253431;4406.339049142654;4435.911281774346;4447.310666846644;4918.139325618003;5149.377717202075;5154.587632989352;5160.432352441228;5209.479052094836;4258.957410425856;4305.375720520569;4347.3261644445165;4355.346697995263;4376.978115109468;4555.9772201138785;4584.151931892544;4587.977060114678;4590.42619672541;4594.908101837945;4615.676902616785;4807.495213002584;4823.614110871052;4824.710517368969;4855.150348688965;5074.82238121664;5112.412072611697;5117.667351622133;5123.666961647481;5139.820106296262;4816.783244753924;4817.445993710769;4821.156297647827;4824.541668541483;4870.1233777920315;4756.667033307774;4997.85006449807;5036;5039.143345631325;5093.719845408538;5112.821051263188;5130.846074617767;5147.2279158126585;5169.457206993362;5214.191800270964;4995.300657907968;5011.072951503984;5023.146065168857;5032.38590254849;5075.289459475603;4741.336212930261;4950.430700469492;4975.10448119342;5011.7494125294315;5033.144365457808;4927.260910863399;4957.454679985127;4991.675541089818;5009.77456014473;5012.8496145115705;5046.369203849519;5054.74726263678;5056.469070747518;5089.083964886356;5106.974465127799;4692.319613655933;4875;4933;4945.184044632595;4949.480304568113 08:11:09 INFO - PROCESS | 18444 | |1;ext.html;562.2044806598664;572.9169270455782;578.1616655849017;580.8896309701155;588.3322429043035;26698;38613.42079868801;39739;39917.60082399179;43279.13441731164;40631;40864.387034194435;40937.59062409375;40949.59050409495;40977.38533921994;7844.176361482034;7991.9600401997905;7993.840123197532;7995.840083198333;8001.67993280271;7613.238676132398;7719.4210434217375;7734.806629834243;7738.342240909529;7739.5356278623185;7754.806129846743;7786.104597971221;7787.104482984472;7788.06543214815;7788.766337009899;7713.922860771377;7747.573883436408;7755.302022817974;7760.844783104306;7764.340031097364;7801.4929029612895;7871.527708337518;7874.881876771853;7879.369650427952;7924.841503169962;38716.41925371122;39032.804835975636;39060.41409378862;39064;39162.412563811566;2960.6299212598424;3079.9846000770076;3581.194231297963;3617.7286703497343;3660.194757153449;27835.443291134266;28147.15558533247;29851;30215.546766798514;31388.372232555223;3393.7454690898035;3475.1659601695665;3499.842507087187;3506.2987402519598;3613.94579081314;247621;251295;254039;254373;254537;29730.851345743566;30687.23281917925;55672.16491752627;56517;56619;34303.4854477183;34574.654253457644;34649;34657;34666.82666586651;13048.34758262083;13287.66780830487;13304.534341298007;13314.93342533281;13319.134256273312;10569.048785609331;10650.307729997681;10690.09134223584;10710.303830251165;10713.35719856811;7993.72021979228;8021.5187088774865;8091.919080809234;8142.18578142181;8202.113513891838;3191.2979144588153;3208.4866421372467;3210.1011716719354;3219.806811591312;3253.4794432890626;854.0946596607616;887.8002449448951;889.3685483306924;919.3013309884536;919.7930465645177;27074.458510829674;27596.862015689792;28383.43233135326;28716.569251461246;28795.280117996797;815.3314282288585;924.5100096948628;1005.7737009173023;1007.5214273220308;1020.2908978260186;14736.55790326292;14869.553913382615;14918.776218356734;15070.924645376703;15305.923470382799;411403;412125;412955;417069;417208;50101.24848127281;50502;50562.49437505578;50567.49432505628;50606.74696626493;1066.6106870992032;1158.102470585303;1193.3675152169365;1204.0548169686754;1213.684442045057;27359.316017099733;28967.710322896502;29089.418211635224;29164.70835291705;29323.266918327212;42037.57962420337;42446;42447.787761060994;42489.087991041095;42584.57415425806;290539;292319;292361;294096;297059;20927.8953605231;25995.48009039771;26271.868640656674;27494.587581185897;27740.861295693394;41357;41464;41574.37638435365;41992.580074198864;42267.7886610565;35919.28161436809;35948.46077308895;36003.099922502144;36155.63844361523;36902.446463302535;35605.28789424249;35903;36278.8186059068;36319.818400907825;36405.06354358375;32126.19684507906;32336.35327293394;33062.83468582642;35433.64566354304;35719.46420803638;30481.23796905095;31085.155236099174;31441.925868710066;31598.684013159575;31793.682063179072;24902.136254330984;24925.501489970462;25181.87409062943;25195.49609007773;25552.23343299704 08:11:09 INFO - PROCESS | 18444 | |2;jquery.html;345.8098046074658;349.61891538223335;364.7501461498872;372.96456836600515;380.5623532937122;16255.837441625596;16258.430954916566;16882.831171688296;16904.915475422637;16977.2360243789;15788.84211157888;16510.83489165108;16574.585635359123;16795.664086718258;16836.158192090377;4911.999999999991;5151.4333423323405;5173.741312934339;5180.6373553851245;5187.455317191697;3054.9847250763714;3219.4687876500348;5075.187969924813;5634.3520495143175;6047.516198704115;5976.671283079429;6068.453839154476;6073.848153796146;6094.207752992127;6099.298580663214;5924.377940316248;6000.429959153874;6082.361352058037;6089.6955152242435;6094.329623741385;2819.84490853003;4888.73111978841;5198.064348417283;5208.401033881077;5308.23030660552;21361.03875325614;21371;21517.569648607096;21683.891580541997;21695.34913952584;1906.8569857260761;1911.350140952069;1913.23470611755;1951.1707524302115;1995.4911497568028;13301.135426197363;13306.534271300457;13457;13530.93234533831;13933.860661393357;1699.694055070087;1741.2338571028833;1746.4673274651227;1757.2531674038482;1797.5775692712202;63224;65569.3443065568;65715;66799;67654;9085.318601104811;9154.496502692416;9505.714828555154;9555.283353748497;9646.614135434644;13136.34318284101;13234.602961911158;13242.73514529704;13278.800817987738;13331.533396331082;7185.6047917364;7191.173015103225;7379.372753316028;7409.036825212688;7472.40220782347;7022.470506523366;7034.964825175842;7215.747448839265;7404.333609975128;7426.814329641694;6135.877282454326;6193.071039344134;6198.411150940653;6231.40801623845;6293.465055470245;1550.387596899241;1577.8579927806552;1689.6958547461575;1698.830116988316;1745.7817772778403;805.3597390074905;839.8656215005569;864.5302984925652;874.807542340684;910.7313342563959;17896;18171.54571135706;18257;18302.542436439195;18610.16254268561;873.1268731268731;874.4709450782312;879.8812160358398;884.712468447757;900.9954950225207;9806.852897206547;10405.375677459226;10419.687409377731;10501.107405870434;10560.2079844012;388605;391640;392936;393019;393434;71286;73314.63342683253;74005;74758;75154;903.9050899655573;928.2342067794096;934.0519372836576;937.6202637931649;946.3328353510758;15951.601209969844;16168;16191.514254572381;16285.104319262555;16311.205767365818;28678.42643147167;34867.82566087153;35236.29527409489;35301.646983529834;35570.822145889106;49176.50823491719;49473.75263123661;50063.49936500734;50447;50522.24216636827;7324.4140468763435;7338.376238019828;7420.962895185489;7541.622918854145;7580.810479738051;8124.593770311579;11703.707407314545;11953.22304050234;12113.394330283627;12305.753884922073;5382.138857782736;6966.825829354307;7976.800579985546;9255.02822203659;10467.790644186922;10372.377657340583;10496.632617858339;10515.106215971728;10591.099756520782;10988.505517251582;10721.249512534048;10738.838917416402;10791.244612877023;10842.078423334106;11076.390798505838;7450;7520.172780993977;7634.50375725576;7691.5769632670745;7725.1502334744255;10679.89320106789;10692;10712.785744285227;10789.352638841694;10806.13550915909 08:11:09 INFO - PROCESS | 18444 | |3;mootools.html;1190.3869507203797;1349.5951214635606;1406.7045920356725;1443.9639009024772;1657.809351924529;6551.11559939408;7300.963495182524;7528;7542.962285188566;7665.348445382149;7423.035005449297;7581.279778421042;7594.77215683529;7599.620018999056;7621.199774023731;1816.5277027972757;1883.3690713610888;1890.867639265252;2136.5620047890147;2162.4485756132162;1861.7021276595747;2124.2777455665073;2210.027587861344;2211.369759618509;2226.8886555672234;2133.328001679466;2168.035224325176;2174.141214220382;2174.3911704722705;2177.0638625391075;1756.165821234916;2095.025812996956;2106.062802053087;2109.124713244002;2111.6515774897202;2034.806693364128;2120.0883620043373;2123.991104225496;2135.882526461044;2136.5513242219154;7624.847503049963;7685.961570192113;7692.961535192344;7695.884561731523;7700.537967721954;4184.769837658928;4288.592583704574;4294.248506511348;4298.398224248608;4302.41917341158;2688.8655567221563;2739.780817534612;2800.8739606717745;2818.6476690413697;2825.9576106358422;877.0965905117675;888.506878682331;897.1163404047008;921.9032001639798;926.4024704065907;10307;10317.690469285933;10319.845202322047;10330.690079297634;10366.429846358447;3979.0848104936026;4005.178938317638;4122.835086596562;4142.689298302639;4150.377443383456;8757.430767000253;8787.077356877437;8791.560421978875;8803.251723603438;8805.779855503664;4459.7547134907245;4483.08096840147;4485.955140448619;4496.685232033792;4501.3022981437925;3482.6169121396624;3715.3869611513796;4000.5399379071196;4024.6981476389387;4040.1919616076902;3197.536357228189;3294.9176270593425;3299.406106900733;3303.0751389610946;3558.928821423609;1115.6374178392055;1138.334074566388;1138.772245550893;1146.0487795130023;1148.787474317254;685.7702669605638;782.6399856066159;789.8657228271207;802.9197080291924;804.6700852650386;4864.075825593126;4927;4931.137051016058;4980.12847751642;4994.400671919393;392.3232424068459;400.35542776130404;404.3611094470729;410.7761270107798;413.36961134269876;3278.639349671534;3331.5502407175204;3345.6988871001727;3360.344732777085;3369.250723336366;8946.19484246408;9322.25421966241;9343.392679475812;9383.483908384967;9393.074419743936;9168.404053736485;9244.306676999251;9285.396449230779;9315.906840931639;9330.90669093314;7014;7148.571085734872;7167.283271672895;7169.820754481179;7175.928240717526;4789.161896668139;4863.197572400656;4902.044101400193;4909.631777616764;4935.876603084952;8545.786355341166;8549;8584.270337021424;8762.561871906251;8796.47221166732;8694.087120852473;8793.604287806937;8842.823143536965;8846.911530884867;8992.055834137322;6435.678216089271;6447.097406363207;6491.058796474579;6512.185976752906;6531.804045878631;5909.970450147722;6049.213602231682;6956.40870526011;6983.511154219156;7055.118110236221;6571.3757193066585;6626.072349870926;6654.134962455044;6703.66481675924;6745.190577130776;6000.819975400745;6289.874202516015;6387.265464471459;6405.967970160119;6431.485481161402;5767.221425107725;5805.158252053344;5909.556783241188;5922.851928701817;5929.881402372014;4173.4157217988895;4175.060611362419;4188.958110418856;4232.174725928415;4255.914881702287;4049.149678567416;4152.626263636287;4240.915181696287;4257.574242575718;4284.121755040147 08:11:09 INFO - PROCESS | 18444 | |4;prototype.html;289.54107739233314;293.5904413343386;301.7028227196211;305.5386366586454;306.4881647648427;4650.790714417851;4855.247436647325;4869.85390438287;4890.755462226888;4904.313396124546;4676.438827340716;4821.734804585746;4835.331810525372;4847.854564363075;4867.322972365203;3814.8474061037527;3825.234953009395;3830.157365379612;3830.731848770587;3831.3678243089857;3573.285342931411;3606.5852426970973;3796.6583007529316;3809.5047643806265;3809.6380843819793;3741.522098770984;3759.853244760347;3766.5856755756845;3775.679067279271;3794.4118661607495;3742.868999585015;3753.680937120321;3756.7558108722983;3766.152615661482;3775.320442320381;3309.271960168783;3325.4180518409426;3328.6671332866517;3330.400527904976;3335.7664963452326;4569.840055598072;4634.39752832133;4727.267273572602;4730.62155027597;4732.195526760459;4283.828646854122;4307.806148723315;4313.719608225455;4322.913541729179;4326.269492203112;5030.2957585938;5039.823606173766;5044.319016932704;5052.76207329203;5056.494350564951;3333.100062983005;3568.7858728476117;3578.4453409721536;3627.3470775260444;3636.6726994570618;5248;5273.499017593284;5277.182036784305;5282.81510147143;5317.9468205317835;3602.2795440911923;3619.6064515161324;3620.637936206358;3622.909427264287;3633.8190088221436;3681.613430589803;3694;3707.443883417509;3708.740388172802;3717.3494638438706;4006.519217693837;4187.350960601112;4200.474940632421;4221.277276156861;4226.704130710821;4778.259369797687;5018.623603229772;5035.62232832539;5049.2426136079885;5075.796968121308;1210.667066556704;1258.7797135501435;1274.9035829186892;1276.6850144351333;1277.7061275906594;798.6765360029198;803.1406395157126;819.942604017713;821.7904434369198;823.390690888738;4012.719109662354;4024.4505865242095;4038;4044;4049.8380064797666;4607.308903664477;4631.8378856739855;4641.883952901205;4663.836765713184;4666.743329116864;3960.396039603965;4001.4998125234347;4017.9397309040387;4035.8991025224605;4039.838406463767;2390.9043638254625;2449.8407603505716;2465.9260222193;2483.3915690655544;2495.139176983974;4280.743155410685;4344.782760862007;4372.950491881926;4374.234508960919;4375.249900039946;4649.373104196118;4655.790489427984;4656.32483289921;4692.536418380378;4709.929351059737;4187.706860519796;4325.848595299212;4356.825726970886;4421.447319085179;4429.933550996673;4517.728936263835;4577.2447546155845;4578.359029735773;4588.7246765194195;4683.227267500961;4465.1962646723905;4482.820687172477;4514.413126293561;4541.613962813198;4547.1815073287125;4111.301078816548;4333.674974376871;4337.566243375637;4338.308059856596;4373.693841431069;3326.451135562605;3330.300636866285;3342.949855752117;3353.312570923004;3357.244619960489;4581.198290299118;4623.156758593508;4625.635437545865;4663.083010271388;4973.5523802857915;4817.7350245736825;5051.6716413433005;5056.595472362129;5090;5096.592272618256;5063.797448102035;5067.150490071172;5112.897742045064;5130.41000284957;5131.8709883825495;4845.248986407112;5012.699238045729;5029.547340739351;5038.269450929668;5040.807248846763;5130.921976599483;5142.922856157086;5167.328247327823;5187.481251874782;5195.220716892496;5060.2156665716875;5065.961477897096;5069.264956581349;5073.822416215415;5078.644494885322 08:11:09 INFO - PROCESS | 18444 | |5;yui.html;554.0774610273894;570.2415787003283;580.2253990922119;592.8814237152566;605.6003037994924;10729;11278.492467838947;11351.772964540725;11352.716182095452;11527.48126334316;12591.685207869808;12593.433295501702;12714.427850746715;12719.491220351198;12720.681982950431;609.268877347184;734.3867870328282;791.1060501633175;793.7658390774707;796.6375299238832;791.7585136533355;793.0562630469751;795.1690483444785;795.4670370851514;795.8885755994137;638.5881106686185;833.0503226321998;833.4624167412015;834.0700119366923;834.6119054639591;653.6078352988193;655.1057806094694;656.6224420957968;786.34340325828;819.4550623835142;603.1013789453726;603.3031848215319;603.387561624951;603.5292471871946;603.5955909540618;11460.770784584345;11470.598529051527;11510.194286399956;11520.02079823216;11520.193586448951;11161.107111431065;11870.287782733063;12625.684357891127;12810.80783788244;13124.475020999149;11042.392668403234;11277.830832537518;11523.48144333507;11801;11972.940135299268;3962.286788378091;3995.580464051262;4022.5374081980654;4037.596240375968;4185.727927684691;50324.74837625825;52220.477795221945;52271;57778.422215777726;58308.12537811936;9495.14543691071;9934.503274836374;10091.646792362231;10138.594456221816;10168.135708464715;18328.816711832977;18501.444956651052;18525.258989640533;18624.44126676202;18628.627427451374;6851.897221541681;6916.6541672916155;6918.8962165567555;6992.650367481606;7104.2895710429575;3560.2701446203464;3600.3339382214376;3662.487251784752;3667.8349474273723;3718.1076541630355;2721.1428400054315;2821.3792965547545;2823.0683874321426;2825.5620378841313;2826.858657067138;478.5884139639907;481.1867943176021;487.4540514623644;491.1135400601948;492.0184232456273;454.13034039814045;505.93675790526186;524.7140308531859;528.5639347538296;531.4605675239635;7124.643767811589;7156.92843071573;7262.673179706926;7393.889091663629;7513.511621744569;517.8084108879739;542.021591355504;544.5589072850925;551.4320250142359;552.6766841397747;3276.115448828803;3432.828358582061;3504.8948531544092;3507.9649203508147;3540.13266749648;59015.70492147512;59290.70354648199;59310;59689.40310596925;95380.52309738407;54799.72600136974;61514.38485615176;80059;86401.56799215963;89350.55324723334;77106.61446692843;78653.21346786458;78741.60629196702;79108.60445697735;79222.6038869802;6682.766103186365;6812.182538095461;6826.088695165362;6887.139107611549;6956.304369563206;44732;45745.31382029206;46335.768321158175;46372.768136160455;46490.76754616205;61117;65788.67105664441;66925.3307466919;67223.66388168027;67251.66374168098;9600.811504266287;9683.612655493702;9717.465539395118;9796.706098817047;9916.778094877112;9706.75733106678;9708.951455242961;9880.258980576342;9960.452175130438;10059;9481.76295592588;9633.229341652792;9695.030496950249;9758.85361719589;9761.07269809367;8964.238039766433;9003.954980225319;9300.302477314093;9426.764330891783;9565.90434095678;8862.778430539289;8908.242799361868;9007.324450666096;9042.773930651787;9398.389104708172;7575.285026163312;7640.541567505968;8231.917680823115;8241.052278987992;8372.41393102477;8193.303569196447;8376.790580235544;8503.787405314917;8663.740087797376;8667.219950204511 08:11:09 INFO - PROCESS | 18444 | __end_tp_report 08:11:09 INFO - PROCESS | 18444 | __start_cc_report 08:11:09 INFO - PROCESS | 18444 | _x_x_mozilla_cycle_collect,1049 08:11:09 INFO - PROCESS | 18444 | __end_cc_report 08:11:09 INFO - PROCESS | 18444 | __startTimestamp1465571469012__endTimestamp 08:11:09 INFO - PROCESS | 18444 | 08:11:09 INFO - PROCESS | 18444 | ------- Summary: start ------- 08:11:09 INFO - PROCESS | 18444 | Number of tests: 6 08:11:09 INFO - PROCESS | 18444 | 08:11:09 INFO - PROCESS | 18444 | [#0] dojo.html Cycles:165 Average:4727.72 Median:4848.03 stddev:494.74 (10.2%) stddev-sans-first:468.32 08:11:09 INFO - PROCESS | 18444 | Values: 2638.4 2643.0 2681.5 2698.8 2705.4 4596.4 4680.8 4777.7 4859.4 4879.0 4711.9 4735.8 4755.3 4821.9 4845.9 4401.4 4413.0 4455.7 4470.0 4473.7 4404.5 4474.0 4516.1 4516.9 4541.7 4452.9 4507.1 4523.6 4558.7 4568.5 4262.1 4295.7 4307.8 4335.3 4409.1 4335.0 4356.2 4362.6 4362.7 4388.6 4757.4 4833.6 4844.8 4848.0 4852.1 4918.6 5026.1 5039.2 5186.8 5194.2 5180.0 5180.2 5181.3 5189.2 5189.4 4800.9 4810.3 4829.0 4832.3 4833.4 5040.4 5131.9 5163.6 5190.0 5226.3 4981.1 4998.6 5028.2 5048.3 5048.6 5074.5 5075.2 5081.4 5082.0 5115.2 4853.6 5048.3 5092.2 5104.8 5122.0 5086.1 5106.1 5121.5 5126.1 5162.0 4172.7 4363.4 4370.6 4375.5 4428.5 3703.6 3775.8 3780.3 3807.9 3874.2 4383.8 4399.2 4406.3 4435.9 4447.3 4918.1 5149.4 5154.6 5160.4 5209.5 4259.0 4305.4 4347.3 4355.3 4377.0 4556.0 4584.2 4588.0 4590.4 4594.9 4615.7 4807.5 4823.6 4824.7 4855.2 5074.8 5112.4 5117.7 5123.7 5139.8 4816.8 4817.4 4821.2 4824.5 4870.1 4756.7 4997.9 5036.0 5039.1 5093.7 5112.8 5130.8 5147.2 5169.5 5214.2 4995.3 5011.1 5023.1 5032.4 5075.3 4741.3 4950.4 4975.1 5011.7 5033.1 4927.3 4957.5 4991.7 5009.8 5012.8 5046.4 5054.7 5056.5 5089.1 5107.0 4692.3 4875.0 4933.0 4945.2 4949.5 08:11:09 INFO - PROCESS | 18444 | 08:11:09 INFO - PROCESS | 18444 | [#1] ext.html Cycles:180 Average:46295.02 Median:35933.87 stddev:86476.42 (240.7%) stddev-sans-first:86650.84 08:11:09 INFO - PROCESS | 18444 | Values: 562.2 572.9 578.2 580.9 588.3 26698.0 38613.4 39739.0 39917.6 43279.1 40631.0 40864.4 40937.6 40949.6 40977.4 7844.2 7992.0 7993.8 7995.8 8001.7 7613.2 7719.4 7734.8 7738.3 7739.5 7754.8 7786.1 7787.1 7788.1 7788.8 7713.9 7747.6 7755.3 7760.8 7764.3 7801.5 7871.5 7874.9 7879.4 7924.8 38716.4 39032.8 39060.4 39064.0 39162.4 2960.6 3080.0 3581.2 3617.7 3660.2 27835.4 28147.2 29851.0 30215.5 31388.4 3393.7 3475.2 3499.8 3506.3 3613.9 247621.0 251295.0 254039.0 254373.0 254537.0 29730.9 30687.2 55672.2 56517.0 56619.0 34303.5 34574.7 34649.0 34657.0 34666.8 13048.3 13287.7 13304.5 13314.9 13319.1 10569.0 10650.3 10690.1 10710.3 10713.4 7993.7 8021.5 8091.9 8142.2 8202.1 3191.3 3208.5 3210.1 3219.8 3253.5 854.1 887.8 889.4 919.3 919.8 27074.5 27596.9 28383.4 28716.6 28795.3 815.3 924.5 1005.8 1007.5 1020.3 14736.6 14869.6 14918.8 15070.9 15305.9 411403.0 412125.0 412955.0 417069.0 417208.0 50101.2 50502.0 50562.5 50567.5 50606.7 1066.6 1158.1 1193.4 1204.1 1213.7 27359.3 28967.7 29089.4 29164.7 29323.3 42037.6 42446.0 42447.8 42489.1 42584.6 290539.0 292319.0 292361.0 294096.0 297059.0 20927.9 25995.5 26271.9 27494.6 27740.9 41357.0 41464.0 41574.4 41992.6 42267.8 35919.3 35948.5 36003.1 36155.6 36902.4 35605.3 35903.0 36278.8 36319.8 36405.1 32126.2 32336.4 33062.8 35433.6 35719.5 30481.2 31085.2 31441.9 31598.7 31793.7 24902.1 24925.5 25181.9 25195.5 25552.2 08:11:09 INFO - PROCESS | 18444 | 08:11:09 INFO - PROCESS | 18444 | [#2] jquery.html Cycles:180 Average:24249.49 Median:393226.50 stddev:64508.14 (16.4%) stddev-sans-first:64664.14 08:11:09 INFO - PROCESS | 18444 | Values: 345.8 349.6 364.8 373.0 380.6 16255.8 16258.4 16882.8 16904.9 16977.2 15788.8 16510.8 16574.6 16795.7 16836.2 4912.0 5151.4 5173.7 5180.6 5187.5 3055.0 3219.5 5075.2 5634.4 6047.5 5976.7 6068.5 6073.8 6094.2 6099.3 5924.4 6000.4 6082.4 6089.7 6094.3 2819.8 4888.7 5198.1 5208.4 5308.2 21361.0 21371.0 21517.6 21683.9 21695.3 1906.9 1911.4 1913.2 1951.2 1995.5 13301.1 13306.5 13457.0 13530.9 13933.9 1699.7 1741.2 1746.5 1757.3 1797.6 63224.0 65569.3 65715.0 66799.0 67654.0 9085.3 9154.5 9505.7 9555.3 9646.6 13136.3 13234.6 13242.7 13278.8 13331.5 7185.6 7191.2 7379.4 7409.0 7472.4 7022.5 7035.0 7215.7 7404.3 7426.8 6135.9 6193.1 6198.4 6231.4 6293.5 1550.4 1577.9 1689.7 1698.8 1745.8 805.4 839.9 864.5 874.8 910.7 17896.0 18171.5 18257.0 18302.5 18610.2 873.1 874.5 879.9 884.7 901.0 9806.9 10405.4 10419.7 10501.1 10560.2 388605.0 391640.0 392936.0 393019.0 393434.0 71286.0 73314.6 74005.0 74758.0 75154.0 903.9 928.2 934.1 937.6 946.3 15951.6 16168.0 16191.5 16285.1 16311.2 28678.4 34867.8 35236.3 35301.6 35570.8 49176.5 49473.8 50063.5 50447.0 50522.2 7324.4 7338.4 7421.0 7541.6 7580.8 8124.6 11703.7 11953.2 12113.4 12305.8 5382.1 6966.8 7976.8 9255.0 10467.8 10372.4 10496.6 10515.1 10591.1 10988.5 10721.2 10738.8 10791.2 10842.1 11076.4 7450.0 7520.2 7634.5 7691.6 7725.2 10679.9 10692.0 10712.8 10789.4 10806.1 08:11:09 INFO - PROCESS | 18444 | 08:11:09 INFO - PROCESS | 18444 | [#3] mootools.html Cycles:180 Average:4892.93 Median:4826.18 stddev:2806.98 (58.2%) stddev-sans-first:2801.06 08:11:09 INFO - PROCESS | 18444 | Values: 1190.4 1349.6 1406.7 1444.0 1657.8 6551.1 7301.0 7528.0 7543.0 7665.3 7423.0 7581.3 7594.8 7599.6 7621.2 1816.5 1883.4 1890.9 2136.6 2162.4 1861.7 2124.3 2210.0 2211.4 2226.9 2133.3 2168.0 2174.1 2174.4 2177.1 1756.2 2095.0 2106.1 2109.1 2111.7 2034.8 2120.1 2124.0 2135.9 2136.6 7624.8 7686.0 7693.0 7695.9 7700.5 4184.8 4288.6 4294.2 4298.4 4302.4 2688.9 2739.8 2800.9 2818.6 2826.0 877.1 888.5 897.1 921.9 926.4 10307.0 10317.7 10319.8 10330.7 10366.4 3979.1 4005.2 4122.8 4142.7 4150.4 8757.4 8787.1 8791.6 8803.3 8805.8 4459.8 4483.1 4486.0 4496.7 4501.3 3482.6 3715.4 4000.5 4024.7 4040.2 3197.5 3294.9 3299.4 3303.1 3558.9 1115.6 1138.3 1138.8 1146.0 1148.8 685.8 782.6 789.9 802.9 804.7 4864.1 4927.0 4931.1 4980.1 4994.4 392.3 400.4 404.4 410.8 413.4 3278.6 3331.6 3345.7 3360.3 3369.3 8946.2 9322.3 9343.4 9383.5 9393.1 9168.4 9244.3 9285.4 9315.9 9330.9 7014.0 7148.6 7167.3 7169.8 7175.9 4789.2 4863.2 4902.0 4909.6 4935.9 8545.8 8549.0 8584.3 8762.6 8796.5 8694.1 8793.6 8842.8 8846.9 8992.1 6435.7 6447.1 6491.1 6512.2 6531.8 5910.0 6049.2 6956.4 6983.5 7055.1 6571.4 6626.1 6654.1 6703.7 6745.2 6000.8 6289.9 6387.3 6406.0 6431.5 5767.2 5805.2 5909.6 5922.9 5929.9 4173.4 4175.1 4189.0 4232.2 4255.9 4049.1 4152.6 4240.9 4257.6 4284.1 08:11:09 INFO - PROCESS | 18444 | 08:11:09 INFO - PROCESS | 18444 | [#4] prototype.html Cycles:180 Average:4029.32 Median:4373.96 stddev:1170.63 (26.8%) stddev-sans-first:1139.77 08:11:09 INFO - PROCESS | 18444 | Values: 289.5 293.6 301.7 305.5 306.5 4650.8 4855.2 4869.9 4890.8 4904.3 4676.4 4821.7 4835.3 4847.9 4867.3 3814.8 3825.2 3830.2 3830.7 3831.4 3573.3 3606.6 3796.7 3809.5 3809.6 3741.5 3759.9 3766.6 3775.7 3794.4 3742.9 3753.7 3756.8 3766.2 3775.3 3309.3 3325.4 3328.7 3330.4 3335.8 4569.8 4634.4 4727.3 4730.6 4732.2 4283.8 4307.8 4313.7 4322.9 4326.3 5030.3 5039.8 5044.3 5052.8 5056.5 3333.1 3568.8 3578.4 3627.3 3636.7 5248.0 5273.5 5277.2 5282.8 5317.9 3602.3 3619.6 3620.6 3622.9 3633.8 3681.6 3694.0 3707.4 3708.7 3717.3 4006.5 4187.4 4200.5 4221.3 4226.7 4778.3 5018.6 5035.6 5049.2 5075.8 1210.7 1258.8 1274.9 1276.7 1277.7 798.7 803.1 819.9 821.8 823.4 4012.7 4024.5 4038.0 4044.0 4049.8 4607.3 4631.8 4641.9 4663.8 4666.7 3960.4 4001.5 4017.9 4035.9 4039.8 2390.9 2449.8 2465.9 2483.4 2495.1 4280.7 4344.8 4373.0 4374.2 4375.2 4649.4 4655.8 4656.3 4692.5 4709.9 4187.7 4325.8 4356.8 4421.4 4429.9 4517.7 4577.2 4578.4 4588.7 4683.2 4465.2 4482.8 4514.4 4541.6 4547.2 4111.3 4333.7 4337.6 4338.3 4373.7 3326.5 3330.3 3342.9 3353.3 3357.2 4581.2 4623.2 4625.6 4663.1 4973.6 4817.7 5051.7 5056.6 5090.0 5096.6 5063.8 5067.2 5112.9 5130.4 5131.9 4845.2 5012.7 5029.5 5038.3 5040.8 5130.9 5142.9 5167.3 5187.5 5195.2 5060.2 5066.0 5069.3 5073.8 5078.6 08:11:09 INFO - PROCESS | 18444 | 08:11:09 INFO - PROCESS | 18444 | [#5] yui.html Cycles:180 Average:16052.68 Median:603.46 stddev:22776.46 (3774.3%) stddev-sans-first:22810.62 08:11:09 INFO - PROCESS | 18444 | Values: 554.1 570.2 580.2 592.9 605.6 10729.0 11278.5 11351.8 11352.7 11527.5 12591.7 12593.4 12714.4 12719.5 12720.7 609.3 734.4 791.1 793.8 796.6 791.8 793.1 795.2 795.5 795.9 638.6 833.1 833.5 834.1 834.6 653.6 655.1 656.6 786.3 819.5 603.1 603.3 603.4 603.5 603.6 11460.8 11470.6 11510.2 11520.0 11520.2 11161.1 11870.3 12625.7 12810.8 13124.5 11042.4 11277.8 11523.5 11801.0 11972.9 3962.3 3995.6 4022.5 4037.6 4185.7 50324.7 52220.5 52271.0 57778.4 58308.1 9495.1 9934.5 10091.6 10138.6 10168.1 18328.8 18501.4 18525.3 18624.4 18628.6 6851.9 6916.7 6918.9 6992.7 7104.3 3560.3 3600.3 3662.5 3667.8 3718.1 2721.1 2821.4 2823.1 2825.6 2826.9 478.6 481.2 487.5 491.1 492.0 454.1 505.9 524.7 528.6 531.5 7124.6 7156.9 7262.7 7393.9 7513.5 517.8 542.0 544.6 551.4 552.7 3276.1 3432.8 3504.9 3508.0 3540.1 59015.7 59290.7 59310.0 59689.4 95380.5 54799.7 61514.4 80059.0 86401.6 89350.6 77106.6 78653.2 78741.6 79108.6 79222.6 6682.8 6812.2 6826.1 6887.1 6956.3 44732.0 45745.3 46335.8 46372.8 46490.8 61117.0 65788.7 66925.3 67223.7 67251.7 9600.8 9683.6 9717.5 9796.7 9916.8 9706.8 9709.0 9880.3 9960.5 10059.0 9481.8 9633.2 9695.0 9758.9 9761.1 8964.2 9004.0 9300.3 9426.8 9565.9 8862.8 8908.2 9007.3 9042.8 9398.4 7575.3 7640.5 8231.9 8241.1 8372.4 8193.3 8376.8 8503.8 8663.7 8667.2 08:11:09 INFO - PROCESS | 18444 | -------- Summary: end -------- 08:11:09 INFO - PROCESS | 18444 | 08:11:09 INFO - TEST-INFO | 18444: exit 0 08:11:09 INFO - TEST-OK | dromaeo_css | took 1120209ms 08:11:09 INFO - TEST-START | kraken 08:11:09 INFO - operating with platform_type : linux_ 08:11:09 INFO - Initialising browser for kraken test... 08:11:09 INFO - TEST-INFO | started process 18619 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvFA8DY/profile http://localhost:34641/getInfo.html) 08:11:14 INFO - PROCESS | 18619 | __metrics Screen width/height:1600/1200 08:11:14 INFO - PROCESS | 18619 | colorDepth:24 08:11:14 INFO - PROCESS | 18619 | Browser inner width/height: 1024/697 08:11:14 INFO - PROCESS | 18619 | __metrics 08:11:15 ERROR - PROCESS | 18619 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:11:15 INFO - PROCESS | 18619 | console.error: PushService: 08:11:15 INFO - PROCESS | 18619 | stateChangeProcessEnqueue: Error transitioning state 08:11:15 INFO - PROCESS | 18619 | UnknownError 08:11:16 INFO - TEST-INFO | 18619: exit 0 08:11:16 INFO - Browser initialized. 08:11:16 INFO - Running cycle 1/1 for kraken test... 08:11:16 INFO - TEST-INFO | started process 18699 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvFA8DY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:11:28 INFO - PROCESS | 18699 | RSS: Main: 175943680 08:11:28 INFO - PROCESS | 18699 | 08:11:31 INFO - PROCESS | 18699 | Cycle 1(1): loaded http://localhost:34641/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34641/tests/kraken/driver.html?testName=audio-beat-detection) 08:11:32 INFO - PROCESS | 18699 | RSS: Main: 232099840 08:11:32 INFO - PROCESS | 18699 | 08:11:34 INFO - PROCESS | 18699 | Cycle 1(1): loaded http://localhost:34641/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34641/tests/kraken/driver.html?testName=audio-dft) 08:11:35 INFO - PROCESS | 18699 | RSS: Main: 220225536 08:11:35 INFO - PROCESS | 18699 | 08:11:38 INFO - PROCESS | 18699 | Cycle 1(1): loaded http://localhost:34641/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34641/tests/kraken/driver.html?testName=audio-fft) 08:11:39 INFO - PROCESS | 18699 | RSS: Main: 287825920 08:11:39 INFO - PROCESS | 18699 | 08:11:41 INFO - PROCESS | 18699 | Cycle 1(1): loaded http://localhost:34641/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34641/tests/kraken/driver.html?testName=audio-oscillator) 08:11:42 INFO - PROCESS | 18699 | RSS: Main: 197439488 08:11:42 INFO - PROCESS | 18699 | 08:11:44 INFO - PROCESS | 18699 | Cycle 1(1): loaded http://localhost:34641/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34641/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:11:45 INFO - PROCESS | 18699 | RSS: Main: 201699328 08:11:45 INFO - PROCESS | 18699 | 08:11:48 INFO - PROCESS | 18699 | Cycle 1(1): loaded http://localhost:34641/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34641/tests/kraken/driver.html?testName=imaging-darkroom) 08:11:48 INFO - PROCESS | 18699 | RSS: Main: 237715456 08:11:48 INFO - PROCESS | 18699 | 08:11:52 INFO - PROCESS | 18699 | Cycle 1(1): loaded http://localhost:34641/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34641/tests/kraken/driver.html?testName=imaging-desaturate) 08:11:53 INFO - PROCESS | 18699 | RSS: Main: 234012672 08:11:53 INFO - PROCESS | 18699 | 08:11:55 INFO - PROCESS | 18699 | Cycle 1(1): loaded http://localhost:34641/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34641/tests/kraken/driver.html?testName=json-parse-financial) 08:11:56 INFO - PROCESS | 18699 | RSS: Main: 236367872 08:11:56 INFO - PROCESS | 18699 | 08:11:58 INFO - PROCESS | 18699 | Cycle 1(1): loaded http://localhost:34641/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34641/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:11:58 INFO - PROCESS | 18699 | RSS: Main: 224481280 08:11:58 INFO - PROCESS | 18699 | 08:12:00 INFO - PROCESS | 18699 | Cycle 1(1): loaded http://localhost:34641/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34641/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:12:01 INFO - PROCESS | 18699 | RSS: Main: 226201600 08:12:01 INFO - PROCESS | 18699 | 08:12:03 INFO - PROCESS | 18699 | Cycle 1(1): loaded http://localhost:34641/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34641/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:12:04 INFO - PROCESS | 18699 | RSS: Main: 234524672 08:12:04 INFO - PROCESS | 18699 | 08:12:07 INFO - PROCESS | 18699 | Cycle 1(1): loaded http://localhost:34641/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34641/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:12:07 INFO - PROCESS | 18699 | RSS: Main: 240599040 08:12:07 INFO - PROCESS | 18699 | 08:12:10 INFO - PROCESS | 18699 | Cycle 1(1): loaded http://localhost:34641/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34641/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:12:11 INFO - PROCESS | 18699 | RSS: Main: 241356800 08:12:11 INFO - PROCESS | 18699 | 08:12:12 INFO - PROCESS | 18699 | Cycle 1(1): loaded http://localhost:34641/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34641/tests/kraken/driver.html?testName=ai-astar) 08:12:13 INFO - PROCESS | 18699 | RSS: Main: 284655616 08:12:13 INFO - PROCESS | 18699 | 08:12:13 INFO - PROCESS | 18699 | __start_tp_report 08:12:13 INFO - PROCESS | 18699 | _x_x_mozilla_page_load 08:12:13 INFO - PROCESS | 18699 | _x_x_mozilla_page_load_details 08:12:13 INFO - PROCESS | 18699 | |i|pagename|runs| 08:12:13 INFO - PROCESS | 18699 | |0;ai-astar;111;108;114;113;114;112;112;111;112;112 08:12:13 INFO - PROCESS | 18699 | |1;audio-beat-detection;161;132;134;180;136;131;155;139;193;136 08:12:13 INFO - PROCESS | 18699 | |2;audio-dft;171;161;162;161;161;163;161;163;165;163 08:12:13 INFO - PROCESS | 18699 | |3;audio-fft;77;77;76;125;77;76;77;77;99;75 08:12:13 INFO - PROCESS | 18699 | |4;audio-oscillator;88;86;112;86;86;87;122;86;87;138 08:12:13 INFO - PROCESS | 18699 | |5;imaging-gaussian-blur;117;118;117;117;117;118;118;117;119;117 08:12:13 INFO - PROCESS | 18699 | |6;imaging-darkroom;146;148;146;147;146;146;146;146;147;147 08:12:13 INFO - PROCESS | 18699 | |7;imaging-desaturate;95;95;94;94;95;95;95;95;94;95 08:12:13 INFO - PROCESS | 18699 | |8;json-parse-financial;63;63;63;64;64;65;65;64;63;64 08:12:13 INFO - PROCESS | 18699 | |9;json-stringify-tinderbox;65;66;66;66;67;65;65;65;65;65 08:12:13 INFO - PROCESS | 18699 | |10;stanford-crypto-aes;89;86;85;83;88;86;84;86;112;84 08:12:13 INFO - PROCESS | 18699 | |11;stanford-crypto-ccm;134;141;133;129;127;132;150;135;135;133 08:12:13 INFO - PROCESS | 18699 | |12;stanford-crypto-pbkdf2;176;169;173;170;165;168;167;166;164;165 08:12:13 INFO - PROCESS | 18699 | |13;stanford-crypto-sha256-iterative;68;67;68;69;66;67;68;66;66;65 08:12:13 INFO - PROCESS | 18699 | __end_tp_report 08:12:13 INFO - PROCESS | 18699 | __start_cc_report 08:12:13 INFO - PROCESS | 18699 | _x_x_mozilla_cycle_collect,1888 08:12:13 INFO - PROCESS | 18699 | __end_cc_report 08:12:13 INFO - PROCESS | 18699 | __startTimestamp1465571533182__endTimestamp 08:12:13 INFO - PROCESS | 18699 | 08:12:13 INFO - PROCESS | 18699 | ------- Summary: start ------- 08:12:13 INFO - PROCESS | 18699 | Number of tests: 14 08:12:13 INFO - PROCESS | 18699 | 08:12:13 INFO - PROCESS | 18699 | [#0] ai-astar Cycles:10 Average:111.90 Median:112.00 stddev:1.73 (1.5%) stddev-sans-first:1.80 08:12:13 INFO - PROCESS | 18699 | Values: 111.0 108.0 114.0 113.0 114.0 112.0 112.0 111.0 112.0 112.0 08:12:13 INFO - PROCESS | 18699 | 08:12:13 INFO - PROCESS | 18699 | [#1] audio-beat-detection Cycles:10 Average:149.70 Median:147.00 stddev:21.98 (15.0%) stddev-sans-first:22.93 08:12:13 INFO - PROCESS | 18699 | Values: 161.0 132.0 134.0 180.0 136.0 131.0 155.0 139.0 193.0 136.0 08:12:13 INFO - PROCESS | 18699 | 08:12:13 INFO - PROCESS | 18699 | [#2] audio-dft Cycles:10 Average:163.10 Median:163.00 stddev:3.07 (1.9%) stddev-sans-first:1.39 08:12:13 INFO - PROCESS | 18699 | Values: 171.0 161.0 162.0 161.0 161.0 163.0 161.0 163.0 165.0 163.0 08:12:13 INFO - PROCESS | 18699 | 08:12:13 INFO - PROCESS | 18699 | [#3] audio-fft Cycles:10 Average:83.60 Median:77.00 stddev:16.19 (21.0%) stddev-sans-first:16.99 08:12:13 INFO - PROCESS | 18699 | Values: 77.0 77.0 76.0 125.0 77.0 76.0 77.0 77.0 99.0 75.0 08:12:13 INFO - PROCESS | 18699 | 08:12:13 INFO - PROCESS | 18699 | [#4] audio-oscillator Cycles:10 Average:97.80 Median:86.00 stddev:19.12 (22.2%) stddev-sans-first:19.95 08:12:13 INFO - PROCESS | 18699 | Values: 88.0 86.0 112.0 86.0 86.0 87.0 122.0 86.0 87.0 138.0 08:12:13 INFO - PROCESS | 18699 | 08:12:13 INFO - PROCESS | 18699 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 08:12:13 INFO - PROCESS | 18699 | Values: 117.0 118.0 117.0 117.0 117.0 118.0 118.0 117.0 119.0 117.0 08:12:13 INFO - PROCESS | 18699 | 08:12:13 INFO - PROCESS | 18699 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 08:12:13 INFO - PROCESS | 18699 | Values: 146.0 148.0 146.0 147.0 146.0 146.0 146.0 146.0 147.0 147.0 08:12:13 INFO - PROCESS | 18699 | 08:12:13 INFO - PROCESS | 18699 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 08:12:13 INFO - PROCESS | 18699 | Values: 95.0 95.0 94.0 94.0 95.0 95.0 95.0 95.0 94.0 95.0 08:12:13 INFO - PROCESS | 18699 | 08:12:13 INFO - PROCESS | 18699 | [#8] json-parse-financial Cycles:10 Average:63.80 Median:64.00 stddev:0.79 (1.2%) stddev-sans-first:0.78 08:12:13 INFO - PROCESS | 18699 | Values: 63.0 63.0 63.0 64.0 64.0 65.0 65.0 64.0 63.0 64.0 08:12:13 INFO - PROCESS | 18699 | 08:12:13 INFO - PROCESS | 18699 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:65.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 08:12:13 INFO - PROCESS | 18699 | Values: 65.0 66.0 66.0 66.0 67.0 65.0 65.0 65.0 65.0 65.0 08:12:13 INFO - PROCESS | 18699 | 08:12:13 INFO - PROCESS | 18699 | [#10] stanford-crypto-aes Cycles:10 Average:88.30 Median:86.00 stddev:8.53 (9.9%) stddev-sans-first:9.04 08:12:13 INFO - PROCESS | 18699 | Values: 89.0 86.0 85.0 83.0 88.0 86.0 84.0 86.0 112.0 84.0 08:12:13 INFO - PROCESS | 18699 | 08:12:13 INFO - PROCESS | 18699 | [#11] stanford-crypto-ccm Cycles:10 Average:134.90 Median:134.50 stddev:6.49 (4.8%) stddev-sans-first:6.87 08:12:13 INFO - PROCESS | 18699 | Values: 134.0 141.0 133.0 129.0 127.0 132.0 150.0 135.0 135.0 133.0 08:12:13 INFO - PROCESS | 18699 | 08:12:13 INFO - PROCESS | 18699 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.30 Median:168.50 stddev:3.83 (2.3%) stddev-sans-first:2.88 08:12:13 INFO - PROCESS | 18699 | Values: 176.0 169.0 173.0 170.0 165.0 168.0 167.0 166.0 164.0 165.0 08:12:13 INFO - PROCESS | 18699 | 08:12:13 INFO - PROCESS | 18699 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.50 stddev:1.25 (1.8%) stddev-sans-first:1.27 08:12:13 INFO - PROCESS | 18699 | Values: 68.0 67.0 68.0 69.0 66.0 67.0 68.0 66.0 66.0 65.0 08:12:13 INFO - PROCESS | 18699 | -------- Summary: end -------- 08:12:13 INFO - PROCESS | 18699 | 08:12:14 INFO - TEST-INFO | 18699: exit 0 08:12:14 INFO - TEST-OK | kraken | took 64464ms 08:12:14 INFO - SUITE-END | took 1184s 08:12:14 INFO - Completed test suite (00:19:44) 08:12:14 INFO - javascript benchmark 08:12:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2638.406358569322, 2642.9867850660744, 2681.5173268811614, 2698.797590180736, 2705.4048109415935, 4596.356510088582, 4680.789364478598, 4777.689450185735, 4859.416869975599, 4879.0, 4711.882202944928, 4735.763211839403, 4755.31047998041, 4821.8794530136765, 4845.927311090337, 4401.427814384142, 4413.0, 4455.732656040632, 4469.955300447003, 4473.709208901411, 4404.515503294635, 4473.9552604473865, 4516.1193567254395, 4516.932246016312, 4541.65937554683, 4452.866414007585, 4507.076049409863, 4523.638108951292, 4558.703684260529, 4568.497465278817, 4262.1049579588325, 4295.742255464682, 4307.8492252771, 4335.328024156261, 4409.140217657558, 4335.024619460628, 4356.215881141393, 4362.629176519968, 4362.650987920959, 4388.561143885618, 4757.429108507002, 4833.637477189225, 4844.8304309349005, 4848.03039392123, 4852.078105160008, 4918.631102667314, 5026.095302845486, 5039.21892106724, 5186.818461353834, 5194.168932970744, 5180.015796998596, 5180.248863914711, 5181.326427564431, 5189.169732842727, 5189.3772747270195, 4800.879978000543, 4810.302506136591, 4828.975855120772, 4832.347633069561, 4833.371661684029, 5040.420351659533, 5131.871703207375, 5163.586913046947, 5190.039842629126, 5226.294450249244, 4981.053599816023, 4998.5751211146735, 5028.245763135559, 5048.343715316985, 5048.646594738407, 5074.517920797518, 5075.2387141929, 5081.390233172043, 5081.974590127025, 5115.232715092691, 4853.563179313808, 5048.343715317059, 5092.185250359925, 5104.770285337168, 5121.974390128025, 5086.109930762102, 5106.055379754683, 5121.4878512149235, 5126.077306084941, 5162.045021671003, 4172.666186705056, 4363.432753742057, 4370.628496577827, 4375.518692943773, 4428.535003824616, 3703.6111208323277, 3775.8489660413275, 3780.2628487445236, 3807.8667246646787, 3874.1864208515963, 4383.802728877208, 4399.20814253431, 4406.339049142654, 4435.911281774346, 4447.310666846644, 4918.139325618003, 5149.377717202075, 5154.587632989352, 5160.432352441228, 5209.479052094836, 4258.957410425856, 4305.375720520569, 4347.3261644445165, 4355.346697995263, 4376.978115109468, 4555.9772201138785, 4584.151931892544, 4587.977060114678, 4590.42619672541, 4594.908101837945, 4615.676902616785, 4807.495213002584, 4823.614110871052, 4824.710517368969, 4855.150348688965, 5074.82238121664, 5112.412072611697, 5117.667351622133, 5123.666961647481, 5139.820106296262, 4816.783244753924, 4817.445993710769, 4821.156297647827, 4824.541668541483, 4870.1233777920315, 4756.667033307774, 4997.85006449807, 5036.0, 5039.143345631325, 5093.719845408538, 5112.821051263188, 5130.846074617767, 5147.2279158126585, 5169.457206993362, 5214.191800270964, 4995.300657907968, 5011.072951503984, 5023.146065168857, 5032.38590254849, 5075.289459475603, 4741.336212930261, 4950.430700469492, 4975.10448119342, 5011.7494125294315, 5033.144365457808, 4927.260910863399, 4957.454679985127, 4991.675541089818, 5009.77456014473, 5012.8496145115705, 5046.369203849519, 5054.74726263678, 5056.469070747518, 5089.083964886356, 5106.974465127799, 4692.319613655933, 4875.0, 4933.0, 4945.184044632595, 4949.480304568113], "value": 4696.29001179891, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.2044806598664, 572.9169270455782, 578.1616655849017, 580.8896309701155, 588.3322429043035, 26698.0, 38613.42079868801, 39739.0, 39917.60082399179, 43279.13441731164, 40631.0, 40864.387034194435, 40937.59062409375, 40949.59050409495, 40977.38533921994, 7844.176361482034, 7991.9600401997905, 7993.840123197532, 7995.840083198333, 8001.67993280271, 7613.238676132398, 7719.4210434217375, 7734.806629834243, 7738.342240909529, 7739.5356278623185, 7754.806129846743, 7786.104597971221, 7787.104482984472, 7788.06543214815, 7788.766337009899, 7713.922860771377, 7747.573883436408, 7755.302022817974, 7760.844783104306, 7764.340031097364, 7801.4929029612895, 7871.527708337518, 7874.881876771853, 7879.369650427952, 7924.841503169962, 38716.41925371122, 39032.804835975636, 39060.41409378862, 39064.0, 39162.412563811566, 2960.6299212598424, 3079.9846000770076, 3581.194231297963, 3617.7286703497343, 3660.194757153449, 27835.443291134266, 28147.15558533247, 29851.0, 30215.546766798514, 31388.372232555223, 3393.7454690898035, 3475.1659601695665, 3499.842507087187, 3506.2987402519598, 3613.94579081314, 247621.0, 251295.0, 254039.0, 254373.0, 254537.0, 29730.851345743566, 30687.23281917925, 55672.16491752627, 56517.0, 56619.0, 34303.4854477183, 34574.654253457644, 34649.0, 34657.0, 34666.82666586651, 13048.34758262083, 13287.66780830487, 13304.534341298007, 13314.93342533281, 13319.134256273312, 10569.048785609331, 10650.307729997681, 10690.09134223584, 10710.303830251165, 10713.35719856811, 7993.72021979228, 8021.5187088774865, 8091.919080809234, 8142.18578142181, 8202.113513891838, 3191.2979144588153, 3208.4866421372467, 3210.1011716719354, 3219.806811591312, 3253.4794432890626, 854.0946596607616, 887.8002449448951, 889.3685483306924, 919.3013309884536, 919.7930465645177, 27074.458510829674, 27596.862015689792, 28383.43233135326, 28716.569251461246, 28795.280117996797, 815.3314282288585, 924.5100096948628, 1005.7737009173023, 1007.5214273220308, 1020.2908978260186, 14736.55790326292, 14869.553913382615, 14918.776218356734, 15070.924645376703, 15305.923470382799, 411403.0, 412125.0, 412955.0, 417069.0, 417208.0, 50101.24848127281, 50502.0, 50562.49437505578, 50567.49432505628, 50606.74696626493, 1066.6106870992032, 1158.102470585303, 1193.3675152169365, 1204.0548169686754, 1213.684442045057, 27359.316017099733, 28967.710322896502, 29089.418211635224, 29164.70835291705, 29323.266918327212, 42037.57962420337, 42446.0, 42447.787761060994, 42489.087991041095, 42584.57415425806, 290539.0, 292319.0, 292361.0, 294096.0, 297059.0, 20927.8953605231, 25995.48009039771, 26271.868640656674, 27494.587581185897, 27740.861295693394, 41357.0, 41464.0, 41574.37638435365, 41992.580074198864, 42267.7886610565, 35919.28161436809, 35948.46077308895, 36003.099922502144, 36155.63844361523, 36902.446463302535, 35605.28789424249, 35903.0, 36278.8186059068, 36319.818400907825, 36405.06354358375, 32126.19684507906, 32336.35327293394, 33062.83468582642, 35433.64566354304, 35719.46420803638, 30481.23796905095, 31085.155236099174, 31441.925868710066, 31598.684013159575, 31793.682063179072, 24902.136254330984, 24925.501489970462, 25181.87409062943, 25195.49609007773, 25552.23343299704], "value": 16450.848121833136, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.8098046074658, 349.61891538223335, 364.7501461498872, 372.96456836600515, 380.5623532937122, 16255.837441625596, 16258.430954916566, 16882.831171688296, 16904.915475422637, 16977.2360243789, 15788.84211157888, 16510.83489165108, 16574.585635359123, 16795.664086718258, 16836.158192090377, 4911.999999999991, 5151.4333423323405, 5173.741312934339, 5180.6373553851245, 5187.455317191697, 3054.9847250763714, 3219.4687876500348, 5075.187969924813, 5634.3520495143175, 6047.516198704115, 5976.671283079429, 6068.453839154476, 6073.848153796146, 6094.207752992127, 6099.298580663214, 5924.377940316248, 6000.429959153874, 6082.361352058037, 6089.6955152242435, 6094.329623741385, 2819.84490853003, 4888.73111978841, 5198.064348417283, 5208.401033881077, 5308.23030660552, 21361.03875325614, 21371.0, 21517.569648607096, 21683.891580541997, 21695.34913952584, 1906.8569857260761, 1911.350140952069, 1913.23470611755, 1951.1707524302115, 1995.4911497568028, 13301.135426197363, 13306.534271300457, 13457.0, 13530.93234533831, 13933.860661393357, 1699.694055070087, 1741.2338571028833, 1746.4673274651227, 1757.2531674038482, 1797.5775692712202, 63224.0, 65569.3443065568, 65715.0, 66799.0, 67654.0, 9085.318601104811, 9154.496502692416, 9505.714828555154, 9555.283353748497, 9646.614135434644, 13136.34318284101, 13234.602961911158, 13242.73514529704, 13278.800817987738, 13331.533396331082, 7185.6047917364, 7191.173015103225, 7379.372753316028, 7409.036825212688, 7472.40220782347, 7022.470506523366, 7034.964825175842, 7215.747448839265, 7404.333609975128, 7426.814329641694, 6135.877282454326, 6193.071039344134, 6198.411150940653, 6231.40801623845, 6293.465055470245, 1550.387596899241, 1577.8579927806552, 1689.6958547461575, 1698.830116988316, 1745.7817772778403, 805.3597390074905, 839.8656215005569, 864.5302984925652, 874.807542340684, 910.7313342563959, 17896.0, 18171.54571135706, 18257.0, 18302.542436439195, 18610.16254268561, 873.1268731268731, 874.4709450782312, 879.8812160358398, 884.712468447757, 900.9954950225207, 9806.852897206547, 10405.375677459226, 10419.687409377731, 10501.107405870434, 10560.2079844012, 388605.0, 391640.0, 392936.0, 393019.0, 393434.0, 71286.0, 73314.63342683253, 74005.0, 74758.0, 75154.0, 903.9050899655573, 928.2342067794096, 934.0519372836576, 937.6202637931649, 946.3328353510758, 15951.601209969844, 16168.0, 16191.514254572381, 16285.104319262555, 16311.205767365818, 28678.42643147167, 34867.82566087153, 35236.29527409489, 35301.646983529834, 35570.822145889106, 49176.50823491719, 49473.75263123661, 50063.49936500734, 50447.0, 50522.24216636827, 7324.4140468763435, 7338.376238019828, 7420.962895185489, 7541.622918854145, 7580.810479738051, 8124.593770311579, 11703.707407314545, 11953.22304050234, 12113.394330283627, 12305.753884922073, 5382.138857782736, 6966.825829354307, 7976.800579985546, 9255.02822203659, 10467.790644186922, 10372.377657340583, 10496.632617858339, 10515.106215971728, 10591.099756520782, 10988.505517251582, 10721.249512534048, 10738.838917416402, 10791.244612877023, 10842.078423334106, 11076.390798505838, 7450.0, 7520.172780993977, 7634.50375725576, 7691.5769632670745, 7725.1502334744255, 10679.89320106789, 10692.0, 10712.785744285227, 10789.352638841694, 10806.13550915909], "value": 8290.784088676732, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1190.3869507203797, 1349.5951214635606, 1406.7045920356725, 1443.9639009024772, 1657.809351924529, 6551.11559939408, 7300.963495182524, 7528.0, 7542.962285188566, 7665.348445382149, 7423.035005449297, 7581.279778421042, 7594.77215683529, 7599.620018999056, 7621.199774023731, 1816.5277027972757, 1883.3690713610888, 1890.867639265252, 2136.5620047890147, 2162.4485756132162, 1861.7021276595747, 2124.2777455665073, 2210.027587861344, 2211.369759618509, 2226.8886555672234, 2133.328001679466, 2168.035224325176, 2174.141214220382, 2174.3911704722705, 2177.0638625391075, 1756.165821234916, 2095.025812996956, 2106.062802053087, 2109.124713244002, 2111.6515774897202, 2034.806693364128, 2120.0883620043373, 2123.991104225496, 2135.882526461044, 2136.5513242219154, 7624.847503049963, 7685.961570192113, 7692.961535192344, 7695.884561731523, 7700.537967721954, 4184.769837658928, 4288.592583704574, 4294.248506511348, 4298.398224248608, 4302.41917341158, 2688.8655567221563, 2739.780817534612, 2800.8739606717745, 2818.6476690413697, 2825.9576106358422, 877.0965905117675, 888.506878682331, 897.1163404047008, 921.9032001639798, 926.4024704065907, 10307.0, 10317.690469285933, 10319.845202322047, 10330.690079297634, 10366.429846358447, 3979.0848104936026, 4005.178938317638, 4122.835086596562, 4142.689298302639, 4150.377443383456, 8757.430767000253, 8787.077356877437, 8791.560421978875, 8803.251723603438, 8805.779855503664, 4459.7547134907245, 4483.08096840147, 4485.955140448619, 4496.685232033792, 4501.3022981437925, 3482.6169121396624, 3715.3869611513796, 4000.5399379071196, 4024.6981476389387, 4040.1919616076902, 3197.536357228189, 3294.9176270593425, 3299.406106900733, 3303.0751389610946, 3558.928821423609, 1115.6374178392055, 1138.334074566388, 1138.772245550893, 1146.0487795130023, 1148.787474317254, 685.7702669605638, 782.6399856066159, 789.8657228271207, 802.9197080291924, 804.6700852650386, 4864.075825593126, 4927.0, 4931.137051016058, 4980.12847751642, 4994.400671919393, 392.3232424068459, 400.35542776130404, 404.3611094470729, 410.7761270107798, 413.36961134269876, 3278.639349671534, 3331.5502407175204, 3345.6988871001727, 3360.344732777085, 3369.250723336366, 8946.19484246408, 9322.25421966241, 9343.392679475812, 9383.483908384967, 9393.074419743936, 9168.404053736485, 9244.306676999251, 9285.396449230779, 9315.906840931639, 9330.90669093314, 7014.0, 7148.571085734872, 7167.283271672895, 7169.820754481179, 7175.928240717526, 4789.161896668139, 4863.197572400656, 4902.044101400193, 4909.631777616764, 4935.876603084952, 8545.786355341166, 8549.0, 8584.270337021424, 8762.561871906251, 8796.47221166732, 8694.087120852473, 8793.604287806937, 8842.823143536965, 8846.911530884867, 8992.055834137322, 6435.678216089271, 6447.097406363207, 6491.058796474579, 6512.185976752906, 6531.804045878631, 5909.970450147722, 6049.213602231682, 6956.40870526011, 6983.511154219156, 7055.118110236221, 6571.3757193066585, 6626.072349870926, 6654.134962455044, 6703.66481675924, 6745.190577130776, 6000.819975400745, 6289.874202516015, 6387.265464471459, 6405.967970160119, 6431.485481161402, 5767.221425107725, 5805.158252053344, 5909.556783241188, 5922.851928701817, 5929.881402372014, 4173.4157217988895, 4175.060611362419, 4188.958110418856, 4232.174725928415, 4255.914881702287, 4049.149678567416, 4152.626263636287, 4240.915181696287, 4257.574242575718, 4284.121755040147], "value": 3862.2479113947647, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [289.54107739233314, 293.5904413343386, 301.7028227196211, 305.5386366586454, 306.4881647648427, 4650.790714417851, 4855.247436647325, 4869.85390438287, 4890.755462226888, 4904.313396124546, 4676.438827340716, 4821.734804585746, 4835.331810525372, 4847.854564363075, 4867.322972365203, 3814.8474061037527, 3825.234953009395, 3830.157365379612, 3830.731848770587, 3831.3678243089857, 3573.285342931411, 3606.5852426970973, 3796.6583007529316, 3809.5047643806265, 3809.6380843819793, 3741.522098770984, 3759.853244760347, 3766.5856755756845, 3775.679067279271, 3794.4118661607495, 3742.868999585015, 3753.680937120321, 3756.7558108722983, 3766.152615661482, 3775.320442320381, 3309.271960168783, 3325.4180518409426, 3328.6671332866517, 3330.400527904976, 3335.7664963452326, 4569.840055598072, 4634.39752832133, 4727.267273572602, 4730.62155027597, 4732.195526760459, 4283.828646854122, 4307.806148723315, 4313.719608225455, 4322.913541729179, 4326.269492203112, 5030.2957585938, 5039.823606173766, 5044.319016932704, 5052.76207329203, 5056.494350564951, 3333.100062983005, 3568.7858728476117, 3578.4453409721536, 3627.3470775260444, 3636.6726994570618, 5248.0, 5273.499017593284, 5277.182036784305, 5282.81510147143, 5317.9468205317835, 3602.2795440911923, 3619.6064515161324, 3620.637936206358, 3622.909427264287, 3633.8190088221436, 3681.613430589803, 3694.0, 3707.443883417509, 3708.740388172802, 3717.3494638438706, 4006.519217693837, 4187.350960601112, 4200.474940632421, 4221.277276156861, 4226.704130710821, 4778.259369797687, 5018.623603229772, 5035.62232832539, 5049.2426136079885, 5075.796968121308, 1210.667066556704, 1258.7797135501435, 1274.9035829186892, 1276.6850144351333, 1277.7061275906594, 798.6765360029198, 803.1406395157126, 819.942604017713, 821.7904434369198, 823.390690888738, 4012.719109662354, 4024.4505865242095, 4038.0, 4044.0, 4049.8380064797666, 4607.308903664477, 4631.8378856739855, 4641.883952901205, 4663.836765713184, 4666.743329116864, 3960.396039603965, 4001.4998125234347, 4017.9397309040387, 4035.8991025224605, 4039.838406463767, 2390.9043638254625, 2449.8407603505716, 2465.9260222193, 2483.3915690655544, 2495.139176983974, 4280.743155410685, 4344.782760862007, 4372.950491881926, 4374.234508960919, 4375.249900039946, 4649.373104196118, 4655.790489427984, 4656.32483289921, 4692.536418380378, 4709.929351059737, 4187.706860519796, 4325.848595299212, 4356.825726970886, 4421.447319085179, 4429.933550996673, 4517.728936263835, 4577.2447546155845, 4578.359029735773, 4588.7246765194195, 4683.227267500961, 4465.1962646723905, 4482.820687172477, 4514.413126293561, 4541.613962813198, 4547.1815073287125, 4111.301078816548, 4333.674974376871, 4337.566243375637, 4338.308059856596, 4373.693841431069, 3326.451135562605, 3330.300636866285, 3342.949855752117, 3353.312570923004, 3357.244619960489, 4581.198290299118, 4623.156758593508, 4625.635437545865, 4663.083010271388, 4973.5523802857915, 4817.7350245736825, 5051.6716413433005, 5056.595472362129, 5090.0, 5096.592272618256, 5063.797448102035, 5067.150490071172, 5112.897742045064, 5130.41000284957, 5131.8709883825495, 4845.248986407112, 5012.699238045729, 5029.547340739351, 5038.269450929668, 5040.807248846763, 5130.921976599483, 5142.922856157086, 5167.328247327823, 5187.481251874782, 5195.220716892496, 5060.2156665716875, 5065.961477897096, 5069.264956581349, 5073.822416215415, 5078.644494885322], "value": 3660.72656919202, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.0774610273894, 570.2415787003283, 580.2253990922119, 592.8814237152566, 605.6003037994924, 10729.0, 11278.492467838947, 11351.772964540725, 11352.716182095452, 11527.48126334316, 12591.685207869808, 12593.433295501702, 12714.427850746715, 12719.491220351198, 12720.681982950431, 609.268877347184, 734.3867870328282, 791.1060501633175, 793.7658390774707, 796.6375299238832, 791.7585136533355, 793.0562630469751, 795.1690483444785, 795.4670370851514, 795.8885755994137, 638.5881106686185, 833.0503226321998, 833.4624167412015, 834.0700119366923, 834.6119054639591, 653.6078352988193, 655.1057806094694, 656.6224420957968, 786.34340325828, 819.4550623835142, 603.1013789453726, 603.3031848215319, 603.387561624951, 603.5292471871946, 603.5955909540618, 11460.770784584345, 11470.598529051527, 11510.194286399956, 11520.02079823216, 11520.193586448951, 11161.107111431065, 11870.287782733063, 12625.684357891127, 12810.80783788244, 13124.475020999149, 11042.392668403234, 11277.830832537518, 11523.48144333507, 11801.0, 11972.940135299268, 3962.286788378091, 3995.580464051262, 4022.5374081980654, 4037.596240375968, 4185.727927684691, 50324.74837625825, 52220.477795221945, 52271.0, 57778.422215777726, 58308.12537811936, 9495.14543691071, 9934.503274836374, 10091.646792362231, 10138.594456221816, 10168.135708464715, 18328.816711832977, 18501.444956651052, 18525.258989640533, 18624.44126676202, 18628.627427451374, 6851.897221541681, 6916.6541672916155, 6918.8962165567555, 6992.650367481606, 7104.2895710429575, 3560.2701446203464, 3600.3339382214376, 3662.487251784752, 3667.8349474273723, 3718.1076541630355, 2721.1428400054315, 2821.3792965547545, 2823.0683874321426, 2825.5620378841313, 2826.858657067138, 478.5884139639907, 481.1867943176021, 487.4540514623644, 491.1135400601948, 492.0184232456273, 454.13034039814045, 505.93675790526186, 524.7140308531859, 528.5639347538296, 531.4605675239635, 7124.643767811589, 7156.92843071573, 7262.673179706926, 7393.889091663629, 7513.511621744569, 517.8084108879739, 542.021591355504, 544.5589072850925, 551.4320250142359, 552.6766841397747, 3276.115448828803, 3432.828358582061, 3504.8948531544092, 3507.9649203508147, 3540.13266749648, 59015.70492147512, 59290.70354648199, 59310.0, 59689.40310596925, 95380.52309738407, 54799.72600136974, 61514.38485615176, 80059.0, 86401.56799215963, 89350.55324723334, 77106.61446692843, 78653.21346786458, 78741.60629196702, 79108.60445697735, 79222.6038869802, 6682.766103186365, 6812.182538095461, 6826.088695165362, 6887.139107611549, 6956.304369563206, 44732.0, 45745.31382029206, 46335.768321158175, 46372.768136160455, 46490.76754616205, 61117.0, 65788.67105664441, 66925.3307466919, 67223.66388168027, 67251.66374168098, 9600.811504266287, 9683.612655493702, 9717.465539395118, 9796.706098817047, 9916.778094877112, 9706.75733106678, 9708.951455242961, 9880.258980576342, 9960.452175130438, 10059.0, 9481.76295592588, 9633.229341652792, 9695.030496950249, 9758.85361719589, 9761.07269809367, 8964.238039766433, 9003.954980225319, 9300.302477314093, 9426.764330891783, 9565.90434095678, 8862.778430539289, 8908.242799361868, 9007.324450666096, 9042.773930651787, 9398.389104708172, 7575.285026163312, 7640.541567505968, 8231.917680823115, 8241.052278987992, 8372.41393102477, 8193.303569196447, 8376.790580235544, 8503.787405314917, 8663.740087797376, 8667.219950204511], "value": 6015.957204389117, "unit": "score"}], "name": "dromaeo_css", "value": 6157.206444546972, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 108.0, 114.0, 113.0, 114.0, 112.0, 112.0, 111.0, 112.0, 112.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 132.0, 134.0, 180.0, 136.0, 131.0, 155.0, 139.0, 193.0, 136.0], "value": 149.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 161.0, 162.0, 161.0, 161.0, 163.0, 161.0, 163.0, 165.0, 163.0], "value": 163.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 76.0, 125.0, 77.0, 76.0, 77.0, 77.0, 99.0, 75.0], "value": 83.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 112.0, 86.0, 86.0, 87.0, 122.0, 86.0, 87.0, 138.0], "value": 97.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 119.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 64.0, 64.0, 65.0, 65.0, 64.0, 63.0, 64.0], "value": 63.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 66.0, 67.0, 65.0, 65.0, 65.0, 65.0, 65.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 85.0, 83.0, 88.0, 86.0, 84.0, 86.0, 112.0, 84.0], "value": 88.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 141.0, 133.0, 129.0, 127.0, 132.0, 150.0, 135.0, 135.0, 133.0], "value": 134.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 169.0, 173.0, 170.0, 165.0, 168.0, 167.0, 166.0, 164.0, 165.0], "value": 168.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 68.0, 69.0, 66.0, 67.0, 68.0, 66.0, 66.0, 65.0], "value": 67.0, "unit": "score"}], "name": "kraken", "value": 1552.6000000000001, "alertThreshold": 2.0}]} 08:12:14 INFO - Return code: 0 08:12:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:12:14 ERROR - # TBPL SUCCESS # 08:12:14 INFO - Running post-action listener: _resource_record_post_action 08:12:14 INFO - ##### 08:12:14 INFO - ##### Finished run-tests step (success) 08:12:14 INFO - ##### 08:12:14 INFO - Running post-run listener: _resource_record_post_run 08:12:14 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 0; Write bytes: 534458368; Read time: 0; Write time: 585412 08:12:14 INFO - TinderboxPrint: CPU usage
13.3% 08:12:14 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 08:12:14 INFO - TinderboxPrint: I/O write bytes / time
534,458,368 / 585,412 08:12:14 INFO - TinderboxPrint: CPU idle
8,318.8 (86.7%) 08:12:14 INFO - TinderboxPrint: CPU user
1,222.7 (12.7%) 08:12:14 INFO - TinderboxPrint: Swap in / out
0 / 0 08:12:14 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 170512384; Read time: 0; Write time: 221188 08:12:14 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 296013824; Read time: 0; Write time: 329936 08:12:15 INFO - Running post-run listener: _upload_blobber_files 08:12:15 INFO - Blob upload gear active. 08:12:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:12:15 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 08:12:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:12:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:12:15 INFO - (blobuploader) - INFO - Open directory for files ... 08:12:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:12:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:12:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:12:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:12:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:12:16 INFO - (blobuploader) - INFO - Done attempting. 08:12:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:12:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:12:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:12:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:12:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:12:20 INFO - (blobuploader) - INFO - Done attempting. 08:12:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:12:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:12:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:12:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:12:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:12:20 INFO - (blobuploader) - INFO - Done attempting. 08:12:20 INFO - (blobuploader) - INFO - Iteration through files over. 08:12:20 INFO - Return code: 0 08:12:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:12:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:12:20 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/36b681944eff83923d4c71ae21f6796e845dfe51262195e1c2b8bbf7d9226a98298e9e77cb981cafd5aebb0c8615c958073bc6821de7f638a21b912b4fe135b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e1dde0ed97f0ef4735e719147ac8ee8833630d100795a141e1fe2b8a60477bff3149a299f0ed789f5c998b3fb651c43530f1afe80abd07276b03e7d5eedf8910", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ff99b72405408ccb6a926b97fb28f025429507c56c08542f6c512774ef8ab424f25f5d8fe2b5a34f1bcd8983c15b676dc855fa7f4c548b2848d4f58bebe4c740"} 08:12:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:12:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:12:20 INFO - Contents: 08:12:20 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/36b681944eff83923d4c71ae21f6796e845dfe51262195e1c2b8bbf7d9226a98298e9e77cb981cafd5aebb0c8615c958073bc6821de7f638a21b912b4fe135b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e1dde0ed97f0ef4735e719147ac8ee8833630d100795a141e1fe2b8a60477bff3149a299f0ed789f5c998b3fb651c43530f1afe80abd07276b03e7d5eedf8910", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ff99b72405408ccb6a926b97fb28f025429507c56c08542f6c512774ef8ab424f25f5d8fe2b5a34f1bcd8983c15b676dc855fa7f4c548b2848d4f58bebe4c740"} 08:12:20 INFO - Running post-run listener: copy_logs_to_upload_dir 08:12:20 INFO - Copying logs to upload dir... 08:12:20 INFO - mkdir: /builds/slave/test/build/upload/logs 08:12:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.305450 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-06-10 08:12:20.239786) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-10 08:12:20.242889) ========= 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=836cfdc75598d54cb747368e000001a9-1465569635.883320-28414491 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/36b681944eff83923d4c71ae21f6796e845dfe51262195e1c2b8bbf7d9226a98298e9e77cb981cafd5aebb0c8615c958073bc6821de7f638a21b912b4fe135b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e1dde0ed97f0ef4735e719147ac8ee8833630d100795a141e1fe2b8a60477bff3149a299f0ed789f5c998b3fb651c43530f1afe80abd07276b03e7d5eedf8910", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ff99b72405408ccb6a926b97fb28f025429507c56c08542f6c512774ef8ab424f25f5d8fe2b5a34f1bcd8983c15b676dc855fa7f4c548b2848d4f58bebe4c740"} build_url:https://queue.taskcluster.net/v1/task/PMmmz-aATJmh6QAHK85gig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011251 build_url: 'https://queue.taskcluster.net/v1/task/PMmmz-aATJmh6QAHK85gig/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/36b681944eff83923d4c71ae21f6796e845dfe51262195e1c2b8bbf7d9226a98298e9e77cb981cafd5aebb0c8615c958073bc6821de7f638a21b912b4fe135b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e1dde0ed97f0ef4735e719147ac8ee8833630d100795a141e1fe2b8a60477bff3149a299f0ed789f5c998b3fb651c43530f1afe80abd07276b03e7d5eedf8910", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ff99b72405408ccb6a926b97fb28f025429507c56c08542f6c512774ef8ab424f25f5d8fe2b5a34f1bcd8983c15b676dc855fa7f4c548b2848d4f58bebe4c740"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-10 08:12:20.270651) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 08:12:20.271053) ========= 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=836cfdc75598d54cb747368e000001a9-1465569635.883320-28414491 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004461 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 08:12:20.352203) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-10 08:12:20.355577) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-10 08:12:20.355903) ========= ========= Total master_lag: 0.18 =========