builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-002 starttime: 1467072481.05 results: success (0) buildid: 20160627143021 builduid: 88e212ebde5c45c9a2b84c8838b4f195 revision: 4de69b1eea157e7a9d80b247402a00990add3e37 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 17:08:01.047701) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 17:08:01.048176) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 17:08:01.048542) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 17:08:01.083924) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 17:08:01.084928) ========= 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=a0d2d2de893abaa8702a9954000001a7-1467071948.857008-1409102459 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-27 17:08:01-- 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% 46.0M=0s 2016-06-27 17:08:01 (46.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.126809 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 17:08:01.231136) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 17:08:01.231521) ========= 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=a0d2d2de893abaa8702a9954000001a7-1467071948.857008-1409102459 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023291 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 17:08:01.285335) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-27 17:08:01.285714) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4de69b1eea157e7a9d80b247402a00990add3e37 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 4de69b1eea157e7a9d80b247402a00990add3e37 --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=a0d2d2de893abaa8702a9954000001a7-1467071948.857008-1409102459 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-27 17:08:01,548 truncating revision to first 12 chars 2016-06-27 17:08:01,548 Setting DEBUG logging. 2016-06-27 17:08:01,548 attempt 1/10 2016-06-27 17:08:01,548 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4de69b1eea15?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 17:08:02,759 unpacking tar archive at: fx-team-4de69b1eea15/testing/mozharness/ program finished with exit code 0 elapsedTime=1.589648 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-27 17:08:02.894737) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 17:08:02.895224) ========= script_repo_revision: 4de69b1eea157e7a9d80b247402a00990add3e37 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 17:08:02.895722) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 17:08:02.896030) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 17:08:02.907637) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-27 17:08:02.908457) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a0d2d2de893abaa8702a9954000001a7-1467071948.857008-1409102459 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:08:03 INFO - MultiFileLogger online at 20160627 17:08:03 in /builds/slave/test 17:08:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:08:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:08:03 INFO - {'append_to_log': False, 17:08:03 INFO - 'base_work_dir': '/builds/slave/test', 17:08:03 INFO - 'blob_upload_branch': 'Fx-Team', 17:08:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:08:03 INFO - 'branch': 'Fx-Team', 17:08:03 INFO - 'buildbot_json_path': 'buildprops.json', 17:08:03 INFO - 'config_files': ('talos/linux_config.py',), 17:08:03 INFO - 'default_actions': ('clobber', 17:08:03 INFO - 'read-buildbot-config', 17:08:03 INFO - 'download-and-extract', 17:08:03 INFO - 'populate-webroot', 17:08:03 INFO - 'create-virtualenv', 17:08:03 INFO - 'install', 17:08:03 INFO - 'run-tests'), 17:08:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:08:03 INFO - 'download_minidump_stackwalk': True, 17:08:03 INFO - 'download_symbols': 'ondemand', 17:08:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:08:03 INFO - 'tooltool.py': '/tools/tooltool.py', 17:08:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:08:03 INFO - '/tools/misc-python/virtualenv.py')}, 17:08:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:08:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:08:03 INFO - 'installer_path': 'installer.exe', 17:08:03 INFO - 'log_level': 'info', 17:08:03 INFO - 'log_name': 'talos', 17:08:03 INFO - 'log_to_console': True, 17:08:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:08:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:08:03 INFO - 'opt_config_files': (), 17:08:03 INFO - 'pip_index': False, 17:08:03 INFO - 'sps_profile': False, 17:08:03 INFO - 'sps_profile_interval': 0, 17:08:03 INFO - 'suite': 'dromaeojs-e10s', 17:08:03 INFO - 'system_bits': '32', 17:08:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:08:03 INFO - 'title': 'talos-linux64-ix-002', 17:08:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:08:03 INFO - 'use_talos_json': True, 17:08:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:08:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:08:03 INFO - 'work_dir': 'build'} 17:08:03 INFO - ##### 17:08:03 INFO - ##### Running clobber step. 17:08:03 INFO - ##### 17:08:03 INFO - Running pre-action listener: _resource_record_pre_action 17:08:03 INFO - Running main action method: clobber 17:08:03 INFO - rmtree: /builds/slave/test/build 17:08:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:08:04 INFO - Running post-action listener: _resource_record_post_action 17:08:04 INFO - ##### 17:08:04 INFO - ##### Finished clobber step (success) 17:08:04 INFO - ##### 17:08:04 INFO - ##### 17:08:04 INFO - ##### Running read-buildbot-config step. 17:08:04 INFO - ##### 17:08:04 INFO - Running pre-action listener: _resource_record_pre_action 17:08:04 INFO - Running main action method: read_buildbot_config 17:08:04 INFO - Using buildbot properties: 17:08:04 INFO - { 17:08:04 INFO - "project": "", 17:08:04 INFO - "product": "firefox", 17:08:04 INFO - "script_repo_revision": "production", 17:08:04 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 17:08:04 INFO - "repository": "", 17:08:04 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 17:08:04 INFO - "buildid": "20160627143021", 17:08:04 INFO - "pgo_build": "True", 17:08:04 INFO - "basedir": "/builds/slave/test", 17:08:04 INFO - "buildnumber": 508, 17:08:04 INFO - "slavename": "talos-linux64-ix-002", 17:08:04 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:08:04 INFO - "platform": "ubuntu64_hw", 17:08:04 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:08:04 INFO - "branch": "fx-team", 17:08:04 INFO - "repo_path": "integration/fx-team", 17:08:04 INFO - "revision": "4de69b1eea157e7a9d80b247402a00990add3e37", 17:08:04 INFO - "stage_platform": "linux64-pgo", 17:08:04 INFO - "builduid": "88e212ebde5c45c9a2b84c8838b4f195", 17:08:04 INFO - "slavebuilddir": "test" 17:08:04 INFO - } 17:08:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/N0p-jvidTqKPz4Ar4B817w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 17:08:04 INFO - Running post-action listener: _resource_record_post_action 17:08:04 INFO - ##### 17:08:04 INFO - ##### Finished read-buildbot-config step (success) 17:08:04 INFO - ##### 17:08:04 INFO - ##### 17:08:04 INFO - ##### Running download-and-extract step. 17:08:04 INFO - ##### 17:08:04 INFO - Running pre-action listener: _resource_record_pre_action 17:08:04 INFO - Running main action method: download_and_extract 17:08:04 INFO - mkdir: /builds/slave/test/build/tests 17:08: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')]} 17:08:04 INFO - https://queue.taskcluster.net/v1/task/N0p-jvidTqKPz4Ar4B817w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:08:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0p-jvidTqKPz4Ar4B817w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:08:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0p-jvidTqKPz4Ar4B817w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:08:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0p-jvidTqKPz4Ar4B817w/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 17:08:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0p-jvidTqKPz4Ar4B817w/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 17:08:05 INFO - Downloaded 1361 bytes. 17:08:05 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:08:05 INFO - Using the following test package requirements: 17:08:05 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:08:05 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:08:05 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:08:05 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:05 INFO - u'jsshell-linux-x86_64.zip'], 17:08:05 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:08:05 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:08:05 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:08:05 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:08:05 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:08:05 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:08:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:08:05 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:08:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:05 INFO - https://queue.taskcluster.net/v1/task/N0p-jvidTqKPz4Ar4B817w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:08:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0p-jvidTqKPz4Ar4B817w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:08:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0p-jvidTqKPz4Ar4B817w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:08:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0p-jvidTqKPz4Ar4B817w/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 17:08:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0p-jvidTqKPz4Ar4B817w/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 17:08:07 INFO - Downloaded 24279844 bytes. 17:08:07 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'] 17:08:07 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 17:08:08 INFO - Return code: 0 17:08:08 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 17:08: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')]} 17:08:08 INFO - https://queue.taskcluster.net/v1/task/N0p-jvidTqKPz4Ar4B817w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:08:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0p-jvidTqKPz4Ar4B817w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:08:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0p-jvidTqKPz4Ar4B817w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:08:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0p-jvidTqKPz4Ar4B817w/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 17:08:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0p-jvidTqKPz4Ar4B817w/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 17:08:18 INFO - Downloaded 24279844 bytes. 17:08:18 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'] 17:08:18 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 17:08:19 INFO - Return code: 0 17:08:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:19 INFO - https://queue.taskcluster.net/v1/task/N0p-jvidTqKPz4Ar4B817w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:08:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0p-jvidTqKPz4Ar4B817w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:08:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0p-jvidTqKPz4Ar4B817w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:08:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0p-jvidTqKPz4Ar4B817w/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 17:08:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0p-jvidTqKPz4Ar4B817w/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 17:08:21 INFO - Downloaded 14405245 bytes. 17:08:21 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'] 17:08:21 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 17:08:21 INFO - Return code: 0 17:08:21 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')]} 17:08:21 INFO - https://queue.taskcluster.net/v1/task/N0p-jvidTqKPz4Ar4B817w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:08:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0p-jvidTqKPz4Ar4B817w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:08:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0p-jvidTqKPz4Ar4B817w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:08:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0p-jvidTqKPz4Ar4B817w/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 17:08:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N0p-jvidTqKPz4Ar4B817w/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 17:08:22 INFO - Downloaded 60297486 bytes. 17:08:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/N0p-jvidTqKPz4Ar4B817w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:08:22 INFO - mkdir: /builds/slave/test/properties 17:08:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:08:22 INFO - Writing to file /builds/slave/test/properties/build_url 17:08:22 INFO - Contents: 17:08:22 INFO - build_url:https://queue.taskcluster.net/v1/task/N0p-jvidTqKPz4Ar4B817w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:08:23 INFO - Running post-action listener: _resource_record_post_action 17:08:23 INFO - Running post-action listener: set_extra_try_arguments 17:08:23 INFO - ##### 17:08:23 INFO - ##### Finished download-and-extract step (success) 17:08:23 INFO - ##### 17:08:23 INFO - ##### 17:08:23 INFO - ##### Running populate-webroot step. 17:08:23 INFO - ##### 17:08:23 INFO - Running pre-action listener: _resource_record_pre_action 17:08:23 INFO - Running main action method: populate_webroot 17:08:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:08:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:08:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:08:23 INFO - '--tppagecycles', 17:08:23 INFO - '7'], 17:08:23 INFO - 'tests': ['tsvgm']}}, 17:08:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:08:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:08:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:08:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:08:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:08:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:08:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:23 INFO - 'talos_options': ['--disable-e10s'], 17:08:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:08:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:08:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:23 INFO - 'talos_options': ['--disable-e10s'], 17:08:23 INFO - 'tests': ['damp', 'tps']}, 17:08:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:23 INFO - 'tests': ['damp', 'tps']}, 17:08:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:08:23 INFO - 'tests': ['dromaeo_dom']}, 17:08:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:08:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:08:23 INFO - 'tests': ['basic_compositor_video']}, 17:08:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:08:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:08:23 INFO - 'tests': ['a11yr', 17:08:23 INFO - 'ts_paint', 17:08:23 INFO - 'tpaint', 17:08:23 INFO - 'sessionrestore', 17:08:23 INFO - 'sessionrestore_no_auto_restore', 17:08:23 INFO - 'tabpaint']}, 17:08:23 INFO - 'other-e10s': {'tests': ['a11yr', 17:08:23 INFO - 'ts_paint', 17:08:23 INFO - 'tpaint', 17:08:23 INFO - 'sessionrestore', 17:08:23 INFO - 'sessionrestore_no_auto_restore', 17:08:23 INFO - 'tabpaint']}, 17:08:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:08:23 INFO - 'ts_paint', 17:08:23 INFO - 'tpaint', 17:08:23 INFO - 'sessionrestore', 17:08:23 INFO - 'sessionrestore_no_auto_restore', 17:08:23 INFO - 'tabpaint']}, 17:08:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:08:23 INFO - 'ts_paint', 17:08:23 INFO - 'tpaint', 17:08:23 INFO - 'sessionrestore', 17:08:23 INFO - 'sessionrestore_no_auto_restore', 17:08:23 INFO - 'tabpaint']}, 17:08:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:08:23 INFO - 'tests': ['a11yr', 17:08:23 INFO - 'ts_paint', 17:08:23 INFO - 'tpaint', 17:08:23 INFO - 'sessionrestore', 17:08:23 INFO - 'sessionrestore_no_auto_restore', 17:08:23 INFO - 'tabpaint']}, 17:08:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:08:23 INFO - 'tests': ['a11yr', 17:08:23 INFO - 'ts_paint', 17:08:23 INFO - 'tpaint', 17:08:23 INFO - 'sessionrestore', 17:08:23 INFO - 'sessionrestore_no_auto_restore', 17:08:23 INFO - 'tabpaint']}, 17:08:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:08:23 INFO - 'tests': ['tsvgx', 17:08:23 INFO - 'tsvgr_opacity', 17:08:23 INFO - 'tart', 17:08:23 INFO - 'tscrollx', 17:08:23 INFO - 'cart']}, 17:08:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:08:23 INFO - 'tsvgr_opacity', 17:08:23 INFO - 'tart', 17:08:23 INFO - 'tscrollx', 17:08:23 INFO - 'cart']}, 17:08:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:23 INFO - 'talos_options': ['--disable-e10s'], 17:08:23 INFO - 'tests': ['tp5o']}, 17:08:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:23 INFO - 'tests': ['tp5o']}, 17:08:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:23 INFO - 'talos_options': ['--disable-e10s', 17:08:23 INFO - '--xperf_path', 17:08:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:08:23 INFO - 'tests': ['tp5n']}, 17:08:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:23 INFO - 'talos_options': ['--xperf_path', 17:08:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:08:23 INFO - 'tests': ['tp5n']}}, 17:08:23 INFO - 'talos.zip': {'path': '', 17:08:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:08:23 INFO - Running post-action listener: _resource_record_post_action 17:08:23 INFO - ##### 17:08:23 INFO - ##### Finished populate-webroot step (success) 17:08:23 INFO - ##### 17:08:23 INFO - ##### 17:08:23 INFO - ##### Running create-virtualenv step. 17:08:23 INFO - ##### 17:08:23 INFO - Running pre-action listener: _resource_record_pre_action 17:08:23 INFO - Running main action method: create_virtualenv 17:08:23 INFO - Creating virtualenv /builds/slave/test/build/venv 17:08:23 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 17:08:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:08:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:08:23 INFO - Using real prefix '/usr' 17:08:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:08:24 INFO - Installing distribute.............................................................................................................................................................................................done. 17:08:26 INFO - Installing pip.................done. 17:08:26 INFO - Return code: 0 17:08:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:08:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7aeda5bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d44480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd36f0>, '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 0x1dd45f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd4aa0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1467071948.857008-1409102459', '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 17:08:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:08:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:08:26 INFO - Using env: {'DISPLAY': ':0', 17:08:26 INFO - 'HOME': '/home/cltbld', 17:08:26 INFO - 'LANG': 'en_US.UTF-8', 17:08:26 INFO - 'LANGUAGE': 'en_US:en', 17:08:26 INFO - 'LOGNAME': 'cltbld', 17:08:26 INFO - 'MAIL': '/var/mail/cltbld', 17:08:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:26 INFO - 'MOZ_NO_REMOTE': '1', 17:08:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:26 INFO - 'NO_EM_RESTART': '1', 17:08:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:26 INFO - 'PWD': '/builds/slave/test', 17:08:26 INFO - 'SHELL': '/bin/bash', 17:08:26 INFO - 'SHLVL': '1', 17:08:26 INFO - 'TERM': 'linux', 17:08:26 INFO - 'TMOUT': '86400', 17:08:26 INFO - 'USER': 'cltbld', 17:08:26 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1467071948.857008-1409102459', 17:08:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:26 INFO - '_': '/tools/buildbot/bin/python'} 17:08:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:26 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 17:08:26 INFO - Cleaning up... 17:08:26 INFO - Return code: 0 17:08:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:08:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7aeda5bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d44480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd36f0>, '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 0x1dd45f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd4aa0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1467071948.857008-1409102459', '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 17:08:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:08:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:08:26 INFO - Using env: {'DISPLAY': ':0', 17:08:26 INFO - 'HOME': '/home/cltbld', 17:08:26 INFO - 'LANG': 'en_US.UTF-8', 17:08:26 INFO - 'LANGUAGE': 'en_US:en', 17:08:26 INFO - 'LOGNAME': 'cltbld', 17:08:26 INFO - 'MAIL': '/var/mail/cltbld', 17:08:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:26 INFO - 'MOZ_NO_REMOTE': '1', 17:08:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:26 INFO - 'NO_EM_RESTART': '1', 17:08:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:26 INFO - 'PWD': '/builds/slave/test', 17:08:26 INFO - 'SHELL': '/bin/bash', 17:08:26 INFO - 'SHLVL': '1', 17:08:26 INFO - 'TERM': 'linux', 17:08:26 INFO - 'TMOUT': '86400', 17:08:26 INFO - 'USER': 'cltbld', 17:08:26 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1467071948.857008-1409102459', 17:08:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:26 INFO - '_': '/tools/buildbot/bin/python'} 17:08:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:26 INFO - Downloading/unpacking psutil>=3.1.1 17:08:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:08:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:08:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:08:28 INFO - Installing collected packages: psutil 17:08:28 INFO - Running setup.py install for psutil 17:08:28 INFO - building 'psutil._psutil_linux' extension 17:08:28 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 17:08:28 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 17:08:28 INFO - building 'psutil._psutil_posix' extension 17:08:28 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 17:08:28 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 17:08:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:08:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:08:28 INFO - Successfully installed psutil 17:08:28 INFO - Cleaning up... 17:08:28 INFO - Return code: 0 17:08:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:08: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')]} 17:08:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:29 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')]} 17:08:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:29 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 0x7f7aeda5bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d44480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd36f0>, '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 0x1dd45f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd4aa0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1467071948.857008-1409102459', '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 17:08:29 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 17:08:29 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 17:08:29 INFO - Using env: {'DISPLAY': ':0', 17:08:29 INFO - 'HOME': '/home/cltbld', 17:08:29 INFO - 'LANG': 'en_US.UTF-8', 17:08:29 INFO - 'LANGUAGE': 'en_US:en', 17:08:29 INFO - 'LOGNAME': 'cltbld', 17:08:29 INFO - 'MAIL': '/var/mail/cltbld', 17:08:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:29 INFO - 'MOZ_NO_REMOTE': '1', 17:08:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:29 INFO - 'NO_EM_RESTART': '1', 17:08:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:29 INFO - 'PWD': '/builds/slave/test', 17:08:29 INFO - 'SHELL': '/bin/bash', 17:08:29 INFO - 'SHLVL': '1', 17:08:29 INFO - 'TERM': 'linux', 17:08:29 INFO - 'TMOUT': '86400', 17:08:29 INFO - 'USER': 'cltbld', 17:08:29 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1467071948.857008-1409102459', 17:08:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:29 INFO - '_': '/tools/buildbot/bin/python'} 17:08:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:08:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:08:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:08:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:08:31 INFO - Installing collected packages: mozsystemmonitor 17:08:31 INFO - Running setup.py install for mozsystemmonitor 17:08:31 INFO - Successfully installed mozsystemmonitor 17:08:31 INFO - Cleaning up... 17:08:31 INFO - Return code: 0 17:08:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:08:31 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')]} 17:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:31 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')]} 17:08:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:31 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 0x7f7aeda5bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d44480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd36f0>, '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 0x1dd45f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd4aa0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1467071948.857008-1409102459', '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 17:08:31 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 17:08:31 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 17:08:31 INFO - Using env: {'DISPLAY': ':0', 17:08:31 INFO - 'HOME': '/home/cltbld', 17:08:31 INFO - 'LANG': 'en_US.UTF-8', 17:08:31 INFO - 'LANGUAGE': 'en_US:en', 17:08:31 INFO - 'LOGNAME': 'cltbld', 17:08:31 INFO - 'MAIL': '/var/mail/cltbld', 17:08:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:31 INFO - 'MOZ_NO_REMOTE': '1', 17:08:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:31 INFO - 'NO_EM_RESTART': '1', 17:08:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:31 INFO - 'PWD': '/builds/slave/test', 17:08:31 INFO - 'SHELL': '/bin/bash', 17:08:31 INFO - 'SHLVL': '1', 17:08:31 INFO - 'TERM': 'linux', 17:08:31 INFO - 'TMOUT': '86400', 17:08:31 INFO - 'USER': 'cltbld', 17:08:31 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1467071948.857008-1409102459', 17:08:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:31 INFO - '_': '/tools/buildbot/bin/python'} 17:08:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:31 INFO - Downloading/unpacking jsonschema==2.5.1 17:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:08:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:08:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:33 INFO - Downloading functools32-3.2.3-2.tar.gz 17:08:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:08:33 INFO - warning: no files found matching '*.txt' 17:08:33 INFO - no previously-included directories found matching 'build' 17:08:33 INFO - no previously-included directories found matching 'dist' 17:08:33 INFO - no previously-included directories found matching '.git*' 17:08:33 INFO - Installing collected packages: jsonschema, functools32 17:08:33 INFO - Running setup.py install for functools32 17:08:33 INFO - warning: no files found matching '*.txt' 17:08:33 INFO - no previously-included directories found matching 'build' 17:08:33 INFO - no previously-included directories found matching 'dist' 17:08:33 INFO - no previously-included directories found matching '.git*' 17:08:33 INFO - Successfully installed jsonschema functools32 17:08:33 INFO - Cleaning up... 17:08:33 INFO - Return code: 0 17:08:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:08:33 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')]} 17:08:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:33 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')]} 17:08:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:33 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 0x7f7aeda5bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d44480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd36f0>, '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 0x1dd45f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd4aa0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1467071948.857008-1409102459', '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 17:08:33 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 17:08:33 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 17:08:33 INFO - Using env: {'DISPLAY': ':0', 17:08:33 INFO - 'HOME': '/home/cltbld', 17:08:33 INFO - 'LANG': 'en_US.UTF-8', 17:08:33 INFO - 'LANGUAGE': 'en_US:en', 17:08:33 INFO - 'LOGNAME': 'cltbld', 17:08:33 INFO - 'MAIL': '/var/mail/cltbld', 17:08:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:33 INFO - 'MOZ_NO_REMOTE': '1', 17:08:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:33 INFO - 'NO_EM_RESTART': '1', 17:08:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:33 INFO - 'PWD': '/builds/slave/test', 17:08:33 INFO - 'SHELL': '/bin/bash', 17:08:33 INFO - 'SHLVL': '1', 17:08:33 INFO - 'TERM': 'linux', 17:08:33 INFO - 'TMOUT': '86400', 17:08:33 INFO - 'USER': 'cltbld', 17:08:33 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1467071948.857008-1409102459', 17:08:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:33 INFO - '_': '/tools/buildbot/bin/python'} 17:08:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:34 INFO - Downloading/unpacking blobuploader==1.2.4 17:08:34 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 17:08:34 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 17:08:34 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 17:08:34 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 17:08:34 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 17:08:34 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 17:08:35 INFO - Downloading blobuploader-1.2.4.tar.gz 17:08:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:08:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:08:36 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 17:08:36 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 17:08:36 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 17:08:36 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 17:08:36 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 17:08:36 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 17:08:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:08:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:08:36 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 17:08:36 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 17:08:36 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 17:08:36 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 17:08:36 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 17:08:36 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 17:08:36 INFO - Downloading docopt-0.6.1.tar.gz 17:08:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:08:36 INFO - Installing collected packages: blobuploader, requests, docopt 17:08:36 INFO - Running setup.py install for blobuploader 17:08:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:08:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:08:36 INFO - Running setup.py install for requests 17:08:37 INFO - Running setup.py install for docopt 17:08:37 INFO - Successfully installed blobuploader requests docopt 17:08:37 INFO - Cleaning up... 17:08:37 INFO - Return code: 0 17:08:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:08:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:37 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 0x7f7aeda5bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d44480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd36f0>, '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 0x1dd45f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd4aa0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1467071948.857008-1409102459', '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 17:08:37 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 17:08:37 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 17:08:37 INFO - Using env: {'DISPLAY': ':0', 17:08:37 INFO - 'HOME': '/home/cltbld', 17:08:37 INFO - 'LANG': 'en_US.UTF-8', 17:08:37 INFO - 'LANGUAGE': 'en_US:en', 17:08:37 INFO - 'LOGNAME': 'cltbld', 17:08:37 INFO - 'MAIL': '/var/mail/cltbld', 17:08:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:37 INFO - 'MOZ_NO_REMOTE': '1', 17:08:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:37 INFO - 'NO_EM_RESTART': '1', 17:08:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:37 INFO - 'PWD': '/builds/slave/test', 17:08:37 INFO - 'SHELL': '/bin/bash', 17:08:37 INFO - 'SHLVL': '1', 17:08:37 INFO - 'TERM': 'linux', 17:08:37 INFO - 'TMOUT': '86400', 17:08:37 INFO - 'USER': 'cltbld', 17:08:37 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1467071948.857008-1409102459', 17:08:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:37 INFO - '_': '/tools/buildbot/bin/python'} 17:08:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:08:37 INFO - Running setup.py (path:/tmp/pip-v7wu8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:08:37 INFO - Running setup.py (path:/tmp/pip-he2lmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:08:37 INFO - Running setup.py (path:/tmp/pip-uhIURz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:08:37 INFO - Running setup.py (path:/tmp/pip-m_rpmr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:08:37 INFO - Running setup.py (path:/tmp/pip-RPCskl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:08:37 INFO - Running setup.py (path:/tmp/pip-K8HjoP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:08:37 INFO - Running setup.py (path:/tmp/pip-wGZwab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:08:38 INFO - Running setup.py (path:/tmp/pip-I8tFC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:08:38 INFO - Running setup.py (path:/tmp/pip-qDgNcE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:08:38 INFO - Running setup.py (path:/tmp/pip-zFx7av-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:08:38 INFO - Running setup.py (path:/tmp/pip-C9Tbq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:08:38 INFO - Running setup.py (path:/tmp/pip-TpsMQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:08:38 INFO - Running setup.py (path:/tmp/pip-0o3liA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:08:38 INFO - Running setup.py (path:/tmp/pip-sLP5yD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:08:38 INFO - Running setup.py (path:/tmp/pip-oqkHXu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:08:38 INFO - Running setup.py (path:/tmp/pip-wzskHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:08:38 INFO - Running setup.py (path:/tmp/pip-wJFsqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:08:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:08:38 INFO - Running setup.py install for manifestparser 17:08:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:08:38 INFO - Running setup.py install for mozcrash 17:08:38 INFO - Running setup.py install for mozdebug 17:08:39 INFO - Running setup.py install for mozdevice 17:08:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:08:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:08:39 INFO - Running setup.py install for mozfile 17:08:39 INFO - Running setup.py install for mozhttpd 17:08:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:08:39 INFO - Running setup.py install for mozinfo 17:08:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:08:39 INFO - Running setup.py install for mozInstall 17:08:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:08:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:08:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:08:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:08:39 INFO - Running setup.py install for mozleak 17:08:39 INFO - Running setup.py install for mozlog 17:08:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:08:39 INFO - Running setup.py install for moznetwork 17:08:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:08:39 INFO - Running setup.py install for mozprocess 17:08:40 INFO - Running setup.py install for mozprofile 17:08:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:08:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:08:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:08:40 INFO - Running setup.py install for mozrunner 17:08:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:08:40 INFO - Running setup.py install for mozscreenshot 17:08:40 INFO - Running setup.py install for moztest 17:08:40 INFO - Running setup.py install for mozversion 17:08:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:08:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:08:40 INFO - Cleaning up... 17:08:40 INFO - Return code: 0 17:08:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:08:40 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')]} 17:08:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:40 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')]} 17:08:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:40 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 0x7f7aeda5bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d44480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd36f0>, '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 0x1dd45f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd4aa0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1467071948.857008-1409102459', '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 17:08:40 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 17:08:40 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 17:08:40 INFO - Using env: {'DISPLAY': ':0', 17:08:40 INFO - 'HOME': '/home/cltbld', 17:08:40 INFO - 'LANG': 'en_US.UTF-8', 17:08:40 INFO - 'LANGUAGE': 'en_US:en', 17:08:40 INFO - 'LOGNAME': 'cltbld', 17:08:40 INFO - 'MAIL': '/var/mail/cltbld', 17:08:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:40 INFO - 'MOZ_NO_REMOTE': '1', 17:08:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:40 INFO - 'NO_EM_RESTART': '1', 17:08:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:40 INFO - 'PWD': '/builds/slave/test', 17:08:40 INFO - 'SHELL': '/bin/bash', 17:08:40 INFO - 'SHLVL': '1', 17:08:40 INFO - 'TERM': 'linux', 17:08:40 INFO - 'TMOUT': '86400', 17:08:40 INFO - 'USER': 'cltbld', 17:08:40 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1467071948.857008-1409102459', 17:08:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:40 INFO - '_': '/tools/buildbot/bin/python'} 17:08:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:08:40 INFO - Running setup.py (path:/tmp/pip-Ch8uC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:08:40 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)) 17:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:08:40 INFO - Running setup.py (path:/tmp/pip-R6dHHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:08:40 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)) 17:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:08:40 INFO - Running setup.py (path:/tmp/pip-FU6lH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:08:40 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)) 17:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:08:41 INFO - Running setup.py (path:/tmp/pip-6eWjfb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:08:41 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)) 17:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:08:41 INFO - Running setup.py (path:/tmp/pip-l5hWO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:08:41 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)) 17:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:08:41 INFO - Running setup.py (path:/tmp/pip-IfBwRv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:08:41 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)) 17:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:08:41 INFO - Running setup.py (path:/tmp/pip-wThmmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:08:41 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)) 17:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:08:41 INFO - Running setup.py (path:/tmp/pip-BlpLda-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:08:41 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)) 17:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:08:41 INFO - Running setup.py (path:/tmp/pip-GvQb5S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:08:41 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)) 17:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:08:41 INFO - Running setup.py (path:/tmp/pip-uXyrtf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:08:41 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)) 17:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:08:41 INFO - Running setup.py (path:/tmp/pip-SVdKF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:08:41 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)) 17:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:08:41 INFO - Running setup.py (path:/tmp/pip-qwcMIg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:08:41 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)) 17:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:08:41 INFO - Running setup.py (path:/tmp/pip-OBFWuY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:08:41 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)) 17:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:08:41 INFO - Running setup.py (path:/tmp/pip-7yWCui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:08:41 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)) 17:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:08:41 INFO - Running setup.py (path:/tmp/pip-3FknKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:08:41 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)) 17:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:08:41 INFO - Running setup.py (path:/tmp/pip-_lkGei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:08:41 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)) 17:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:08:41 INFO - Running setup.py (path:/tmp/pip-SAZ7pd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:08:42 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)) 17:08:42 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)) 17:08:42 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)) 17:08:42 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)) 17:08:42 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)) 17:08:42 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)) 17:08:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:08:42 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 17:08:42 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 17:08:42 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 17:08:42 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 17:08:42 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 17:08:42 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 17:08:43 INFO - Downloading blessings-1.6.tar.gz 17:08:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:08:44 INFO - Installing collected packages: blessings 17:08:44 INFO - Running setup.py install for blessings 17:08:44 INFO - Successfully installed blessings 17:08:44 INFO - Cleaning up... 17:08:44 INFO - Return code: 0 17:08:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:08:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:08:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:08:44 INFO - Reading from file tmpfile_stdout 17:08:44 INFO - Current package versions: 17:08:44 INFO - argparse == 1.2.1 17:08:44 INFO - blessings == 1.6 17:08:44 INFO - blobuploader == 1.2.4 17:08:44 INFO - docopt == 0.6.1 17:08:44 INFO - functools32 == 3.2.3-2 17:08:44 INFO - jsonschema == 2.5.1 17:08:44 INFO - manifestparser == 1.1 17:08:44 INFO - mozInstall == 1.12 17:08:44 INFO - mozcrash == 0.17 17:08:44 INFO - mozdebug == 0.1 17:08:44 INFO - mozdevice == 0.48 17:08:44 INFO - mozfile == 1.2 17:08:44 INFO - mozhttpd == 0.7 17:08:44 INFO - mozinfo == 0.9 17:08:44 INFO - mozleak == 0.1 17:08:44 INFO - mozlog == 3.2 17:08:44 INFO - moznetwork == 0.27 17:08:44 INFO - mozprocess == 0.22 17:08:44 INFO - mozprofile == 0.28 17:08:44 INFO - mozrunner == 6.11 17:08:44 INFO - mozscreenshot == 0.1 17:08:44 INFO - mozsystemmonitor == 0.3 17:08:44 INFO - moztest == 0.7 17:08:44 INFO - mozversion == 1.4 17:08:44 INFO - psutil == 3.1.1 17:08:44 INFO - requests == 1.2.3 17:08:44 INFO - wsgiref == 0.1.2 17:08:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:08: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')]} 17:08:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08: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')]} 17:08:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:44 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 0x7f7aeda5bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d44480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd36f0>, '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 0x1dd45f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd4aa0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1467071948.857008-1409102459', '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 17:08:44 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 17:08:44 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 17:08:44 INFO - Using env: {'DISPLAY': ':0', 17:08:44 INFO - 'HOME': '/home/cltbld', 17:08:44 INFO - 'LANG': 'en_US.UTF-8', 17:08:44 INFO - 'LANGUAGE': 'en_US:en', 17:08:44 INFO - 'LOGNAME': 'cltbld', 17:08:44 INFO - 'MAIL': '/var/mail/cltbld', 17:08:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:44 INFO - 'MOZ_NO_REMOTE': '1', 17:08:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:44 INFO - 'NO_EM_RESTART': '1', 17:08:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:44 INFO - 'PWD': '/builds/slave/test', 17:08:44 INFO - 'SHELL': '/bin/bash', 17:08:44 INFO - 'SHLVL': '1', 17:08:44 INFO - 'TERM': 'linux', 17:08:44 INFO - 'TMOUT': '86400', 17:08:44 INFO - 'USER': 'cltbld', 17:08:44 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1467071948.857008-1409102459', 17:08:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:44 INFO - '_': '/tools/buildbot/bin/python'} 17:08:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:44 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)) 17:08:44 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)) 17:08:44 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)) 17:08:44 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)) 17:08:44 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)) 17:08:44 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)) 17:08:44 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)) 17:08:44 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)) 17:08:44 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)) 17:08:44 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)) 17:08:44 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)) 17:08:44 INFO - Cleaning up... 17:08:44 INFO - Return code: 0 17:08:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:08: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')]} 17:08:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08: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')]} 17:08:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:44 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 0x7f7aeda5bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d44480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd36f0>, '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 0x1dd45f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd4aa0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1467071948.857008-1409102459', '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 17:08:44 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 17:08:44 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 17:08:44 INFO - Using env: {'DISPLAY': ':0', 17:08:44 INFO - 'HOME': '/home/cltbld', 17:08:44 INFO - 'LANG': 'en_US.UTF-8', 17:08:44 INFO - 'LANGUAGE': 'en_US:en', 17:08:44 INFO - 'LOGNAME': 'cltbld', 17:08:44 INFO - 'MAIL': '/var/mail/cltbld', 17:08:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:44 INFO - 'MOZ_NO_REMOTE': '1', 17:08:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:44 INFO - 'NO_EM_RESTART': '1', 17:08:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:44 INFO - 'PWD': '/builds/slave/test', 17:08:44 INFO - 'SHELL': '/bin/bash', 17:08:44 INFO - 'SHLVL': '1', 17:08:44 INFO - 'TERM': 'linux', 17:08:44 INFO - 'TMOUT': '86400', 17:08:44 INFO - 'USER': 'cltbld', 17:08:44 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1467071948.857008-1409102459', 17:08:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:44 INFO - '_': '/tools/buildbot/bin/python'} 17:08:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:08:44 INFO - Cleaning up... 17:08:44 INFO - Return code: 0 17:08:44 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:08: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')]} 17:08:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08: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')]} 17:08:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:44 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 0x7f7aeda5bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d44480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd36f0>, '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 0x1dd45f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd4aa0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1467071948.857008-1409102459', '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 17:08:44 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 17:08:44 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 17:08:44 INFO - Using env: {'DISPLAY': ':0', 17:08:44 INFO - 'HOME': '/home/cltbld', 17:08:44 INFO - 'LANG': 'en_US.UTF-8', 17:08:44 INFO - 'LANGUAGE': 'en_US:en', 17:08:44 INFO - 'LOGNAME': 'cltbld', 17:08:44 INFO - 'MAIL': '/var/mail/cltbld', 17:08:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:44 INFO - 'MOZ_NO_REMOTE': '1', 17:08:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:08:44 INFO - 'NO_EM_RESTART': '1', 17:08:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:08:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:44 INFO - 'PWD': '/builds/slave/test', 17:08:44 INFO - 'SHELL': '/bin/bash', 17:08:44 INFO - 'SHLVL': '1', 17:08:44 INFO - 'TERM': 'linux', 17:08:44 INFO - 'TMOUT': '86400', 17:08:44 INFO - 'USER': 'cltbld', 17:08:44 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1467071948.857008-1409102459', 17:08:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:44 INFO - '_': '/tools/buildbot/bin/python'} 17:08:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:45 INFO - Downloading/unpacking flake8 17:08:45 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 17:08:45 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 17:08:45 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 17:08:45 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 17:08:45 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 17:08:45 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 17:08:46 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:08:46 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:08:46 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 17:08:46 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 17:08:46 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 17:08:46 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 17:08:46 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 17:08:46 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 17:08:47 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:08:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:08:47 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 17:08:47 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 17:08:47 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 17:08:47 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 17:08:47 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 17:08:47 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 17:08:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:08:47 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 17:08:47 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 17:08:47 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 17:08:47 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 17:08:47 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 17:08:47 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 17:08:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:08:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:08:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:08:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:08:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:08:47 INFO - no previously-included directories found matching 'docs/_build' 17:08:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:08:47 INFO - Running setup.py install for pep8 17:08:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:08:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:08:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:08:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:08:47 INFO - no previously-included directories found matching 'docs/_build' 17:08:47 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:08:47 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:08:47 INFO - Cleaning up... 17:08:47 INFO - Return code: 0 17:08:47 INFO - Running post-action listener: _resource_record_post_action 17:08:47 INFO - Running post-action listener: _start_resource_monitoring 17:08:47 INFO - Starting resource monitoring. 17:08:47 INFO - ##### 17:08:47 INFO - ##### Finished create-virtualenv step (success) 17:08:47 INFO - ##### 17:08:47 INFO - ##### 17:08:47 INFO - ##### Running install step. 17:08:47 INFO - ##### 17:08:47 INFO - Running pre-action listener: _resource_record_pre_action 17:08:47 INFO - Running main action method: install 17:08:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:08:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:08:48 INFO - Reading from file tmpfile_stdout 17:08:48 INFO - Detecting whether we're running mozinstall >=1.0... 17:08:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:08:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:08:48 INFO - Reading from file tmpfile_stdout 17:08:48 INFO - Output received: 17:08:48 INFO - Usage: mozinstall [options] installer 17:08:48 INFO - Options: 17:08:48 INFO - -h, --help show this help message and exit 17:08:48 INFO - -d DEST, --destination=DEST 17:08:48 INFO - Directory to install application into. [default: 17:08:48 INFO - "/builds/slave/test"] 17:08:48 INFO - --app=APP Application being installed. [default: firefox] 17:08:48 INFO - mkdir: /builds/slave/test/build/application 17:08:48 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'] 17:08:48 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 17:09:05 INFO - Reading from file tmpfile_stdout 17:09:05 INFO - Output received: 17:09:05 INFO - /builds/slave/test/build/application/firefox/firefox 17:09:05 INFO - Running post-action listener: _resource_record_post_action 17:09:05 INFO - ##### 17:09:05 INFO - ##### Finished install step (success) 17:09:05 INFO - ##### 17:09:05 INFO - ##### 17:09:05 INFO - ##### Running run-tests step. 17:09:05 INFO - ##### 17:09:05 INFO - Running pre-action listener: _resource_record_pre_action 17:09:05 INFO - Running main action method: run_tests 17:09:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:09:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:09:05 INFO - Python 2.7.3 17:09:05 INFO - Return code: 0 17:09:05 INFO - grabbing minidump binary from tooltool 17:09:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:05 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 0x1dd36f0>, '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 0x1dd45f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dd4aa0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:09:05 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 17:09:05 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 17:09:05 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 17:09:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:09:05 INFO - Return code: 0 17:09:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:09:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:09:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:09:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:09:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:09:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:09:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:09:06 INFO - Return code: 0 17:09:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N0p-jvidTqKPz4Ar4B817w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:09:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/N0p-jvidTqKPz4Ar4B817w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:09:06 INFO - Using env: {'DISPLAY': ':0', 17:09:06 INFO - 'HOME': '/home/cltbld', 17:09:06 INFO - 'LANG': 'en_US.UTF-8', 17:09:06 INFO - 'LANGUAGE': 'en_US:en', 17:09:06 INFO - 'LOGNAME': 'cltbld', 17:09:06 INFO - 'MAIL': '/var/mail/cltbld', 17:09:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:09:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:09:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:06 INFO - 'MOZ_NO_REMOTE': '1', 17:09:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:09:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:06 INFO - 'NO_EM_RESTART': '1', 17:09:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:06 INFO - 'PWD': '/builds/slave/test', 17:09:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:09:06 INFO - 'SHELL': '/bin/bash', 17:09:06 INFO - 'SHLVL': '1', 17:09:06 INFO - 'TERM': 'linux', 17:09:06 INFO - 'TMOUT': '86400', 17:09:06 INFO - 'USER': 'cltbld', 17:09:06 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1467071948.857008-1409102459', 17:09:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:06 INFO - '_': '/tools/buildbot/bin/python'} 17:09:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N0p-jvidTqKPz4Ar4B817w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:09:06 INFO - mozversion application_buildid: 20160627143021 17:09:06 INFO - mozversion application_changeset: 4de69b1eea157e7a9d80b247402a00990add3e37 17:09:06 INFO - mozversion application_display_name: Nightly 17:09:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:09:06 INFO - mozversion application_name: Firefox 17:09:06 INFO - mozversion application_remotingname: firefox 17:09:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:09:06 INFO - mozversion application_vendor: Mozilla 17:09:06 INFO - mozversion application_version: 50.0a1 17:09:06 INFO - mozversion platform_buildid: 20160627143021 17:09:06 INFO - mozversion platform_changeset: 4de69b1eea157e7a9d80b247402a00990add3e37 17:09:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:09:06 INFO - mozversion platform_version: 50.0a1 17:09:06 INFO - using testdate: 1467072546 17:09:06 INFO - actual date: 1467072546 17:09:06 INFO - starting webserver on 'localhost:54435' 17:09:06 INFO - SUITE-START | Running 2 tests 17:09:06 INFO - TEST-START | dromaeo_css 17:09:06 INFO - operating with platform_type : linux_ 17:09:06 INFO - Initialising browser for dromaeo_css test... 17:09:06 INFO - TEST-INFO | started process 25532 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkILxZ1/profile http://localhost:54435/getInfo.html) 17:09:11 INFO - PROCESS | 25532 | __metrics Screen width/height:1600/1200 17:09:11 INFO - PROCESS | 25532 | colorDepth:24 17:09:11 INFO - PROCESS | 25532 | Browser inner width/height: 1024/697 17:09:11 INFO - PROCESS | 25532 | __metrics 17:09:12 ERROR - PROCESS | 25532 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 17:09:13 INFO - TEST-INFO | 25532: exit 0 17:09:13 INFO - Browser initialized. 17:09:13 INFO - Running cycle 1/1 for dromaeo_css test... 17:09:13 INFO - TEST-INFO | started process 25651 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkILxZ1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:09:25 INFO - PROCESS | 25651 | RSS: Main: 185217024 17:09:25 INFO - PROCESS | 25651 | 17:10:14 INFO - PROCESS | 25651 | 1467072614645 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] 17:12:22 INFO - PROCESS | 25651 | Cycle 1(1): loaded http://localhost:54435/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54435/tests/dromaeo/cssquery-ext.html) 17:12:23 INFO - PROCESS | 25651 | RSS: Main: 188334080 17:12:23 INFO - PROCESS | 25651 | 17:15:25 INFO - PROCESS | 25651 | Cycle 1(1): loaded http://localhost:54435/tests/dromaeo/cssquery-ext.html (next: http://localhost:54435/tests/dromaeo/cssquery-jquery.html) 17:15:26 INFO - PROCESS | 25651 | RSS: Main: 187977728 17:15:26 INFO - PROCESS | 25651 | 17:18:28 INFO - PROCESS | 25651 | Cycle 1(1): loaded http://localhost:54435/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54435/tests/dromaeo/cssquery-mootools.html) 17:18:29 INFO - PROCESS | 25651 | RSS: Main: 188899328 17:18:29 INFO - PROCESS | 25651 | 17:21:30 INFO - PROCESS | 25651 | Cycle 1(1): loaded http://localhost:54435/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54435/tests/dromaeo/cssquery-prototype.html) 17:21:31 INFO - PROCESS | 25651 | RSS: Main: 186658816 17:21:31 INFO - PROCESS | 25651 | 17:24:33 INFO - PROCESS | 25651 | Cycle 1(1): loaded http://localhost:54435/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54435/tests/dromaeo/cssquery-yui.html) 17:24:34 INFO - PROCESS | 25651 | RSS: Main: 188981248 17:24:34 INFO - PROCESS | 25651 | 17:27:37 INFO - PROCESS | 25651 | Cycle 1(1): loaded http://localhost:54435/tests/dromaeo/cssquery-yui.html (next: http://localhost:54435/tests/dromaeo/cssquery-dojo.html) 17:27:37 INFO - PROCESS | 25651 | RSS: Main: 189698048 17:27:37 INFO - PROCESS | 25651 | 17:27:37 INFO - PROCESS | 25651 | __start_tp_report 17:27:37 INFO - PROCESS | 25651 | _x_x_mozilla_page_load 17:27:37 INFO - PROCESS | 25651 | _x_x_mozilla_page_load_details 17:27:37 INFO - PROCESS | 25651 | |i|pagename|runs| 17:27:37 INFO - PROCESS | 25651 | |0;dojo.html;3104.3480869017503;3118.080166350929;3153.0698443959036;3167.778255522113;3167.8416079196036;5289.735513224337;5452.972735136329;5469.480399362059;5484.972575137129;5501.284832971708;5329.280547126137;5372.91940620891;5374.328208973879;5379.515843574078;5460.918086228709;4840.6127509799135;4867.756612169377;4951.801927922878;5013.298138260647;5060.291559181717;797.6432278194953;4786.641001924852;4829.589484893788;4973.403191617011;4998.150314446553;4864.805407783684;4890.437599676029;4900.607951363918;4914.606831453475;4923.138450771101;4892.437369702494;4908.656394052417;4913.041956818422;4926.261060840867;4954.9009019819405;4857.489963553811;4874.561289483928;4897.069556784235;4945.381827271591;4964.776585053682;5394.244805727201;5398;5447.972760136214;5453.890922181534;5461.836144915659;5691.117876729114;5784.739686714108;5823.4467725566;5838.649681019152;5839.883202335972;5755.712214389306;5809.04150815115;5832.329282132567;5854.560907931879;5879.265091863517;5449.427810079924;5471.5896307776675;5479.917801233025;5481.314835645544;5482.91775623366;5801.796937107181;5907.084401917709;5933.495652869468;5945.732442040118;5958.076498142795;5602.887942241132;5667.631603945731;5688.06146985751;5711.742971566289;5792.652440853562;5771.567132465082;5775.480206781326;5781.219535362757;5782.132680097935;5791.247137872134;5633.295838020247;5681.57388195887;5728.971355143198;5737.942620573825;5742;5709;5744.4829965303325;5780.132980053026;5806.2451881255165;5831.096180092092;4400.207962566768;4402.273624851928;4422.115576884636;4453.198424283595;4454.57681520255;3909.58949310324;3929.5088113985753;3961.6830653547645;3976.224636195914;4017.0760725033406;5487.176923461513;5506.504414602705;5517.613767036269;5572.247746554244;5611.074172761449;5771.8557036074435;5780.1907732917425;5783;5802.187693722883;5810.709464526757;5429.755660995264;5482.068048431776;5491.533219676292;5523.751431185526;5533.1976863354585;4867.5132486751045;4883.3651625288485;4889.071076495455;4922.064807686528;4929.507049295042;6022.427869352405;6028.2766068072115;6028.306744724413;6038.701679139006;6050.515958723292;5652.717364131695;5709.714514274353;5710.828675139753;5750.137479378127;5833.183354330397;5986.700664966647;5995.700214989321;6025;6031.849203769941;6035.849103772265;5653.632513886584;5670.886582268249;5671.886562268649;5676.68778217202;5743.59794814359;5641.746121424464;5736.196932429547;5769.451902069297;5805.564582656402;5836.708164591669;5690.5163061140265;5710.600257981901;5725.599208055396;5726.65640061581;5736.569757268138;5509.614326997072;5639.605227634026;5684.48839604421;5692.402297758841;5699.458551437607;5432.049391356576;5440.646357986719;5470.343558772973;5497.312835895513;5530.364008138955;5623.2127502148915;5666.46168613981;5693.089105743061;5750.827475175752;5755.942440575541;5421.241026256248;5633.605647604629;5651.519620832275;5653.293338332708;5660.066089095253 17:27:37 INFO - PROCESS | 25651 | |1;ext.html;555.8721494056367;596.0998891673573;615.200239688405;615.4553220399947;617.8053913017401;42385.36421953673;43627.78186109073;43728.78135609321;43759.78120109399;47561;45639;45687.31469027967;46025.76987115068;46127.30809037867;46331.536684633145;8648.783780405493;8806.779830504225;8825.293976481866;8835.514046727427;8857.158569935846;8804.20762131408;8893.244074253696;8895.33285003624;8897.77755556113;8898.911010889906;8858.512781796999;8878;8896.421732587361;8902.510361930092;8958.462492250454;8833.425827321236;8838.69064582743;8842.557872106401;8871.157240062184;8877.778055548599;8630.050694423608;8660.090690477535;8688.869666955;8715.564221788949;8718;42335;42412;43028.35457468109;43082.56917430817;43151.35272970908;3389.762716609838;3486.9476957845654;3515.6132825389186;3608.1187664107338;3651.3427583035045;33224.335513289596;33373.66626333754;33699;34842.651573484196;34948.825255873555;4374.8906277343;4413.889652758707;4436.179306828247;4558.544145585448;4625.930611040837;364307;367335;367436;368310;369908;34643.65356346455;61661.69169154126;62459.37540624626;62487.6875615619;62549.37450625526;35089.64910350864;36513.634863651554;36723.26553468969;36732.632673673455;36806.263874722354;15205.467808626645;15305.311260993281;15310.693786124215;15327.31027103783;15358.539243822703;11922.701932451759;11941.462634181482;11965.700857478458;11984.58053968107;12062.276263424223;8351.665933362598;8366.498010119412;8405.579721014046;8435.662573497115;8494.150584941457;3244;3248.561444205002;3274.1159886830897;3278.639349671534;3281.392942305681;952.6808519146025;1030.350878946274;1037.3931250218707;1124.527698366688;1127.7594645889455;31801.681983180333;31977.840110799298;32003.679963200535;32241.51637725436;32669.67330326714;1084.4089970965842;1097.1880808201872;1116.810142275815;1175.3653027365299;1185.17038073349;16454.917725411295;17424.91287543554;18053.27786888536;18890.527736806416;19023.239070437303;613851;618360;621656;621925;621945;59262.70368648216;60842.391576083675;60978.39021609727;61037.38962610406;61157.08264376038;1374.7594171020032;1388.430743395203;1412.7810189420657;1421.8435972043067;1428.4143501164472;31983.840080799448;33793.49309760307;34275;34359.828200858836;34647.4802877952;52930;53001.734991324796;53038;53747.46252537581;53850.192247117106;492222;494010;494561;494876;495876;26012.739872601032;26568.202953911412;26614.733852661226;28473.572896406986;28803.27991800222;50147.11832909598;50380.74809625928;50669.23996140135;50813;51448;40324.1935161301;42122.36816447817;42686.146277074906;43215.35176972285;43326.78336608297;41772.79113604413;41902;42188.578114219694;42370.36444453274;42898;37235;41529.37705934474;41591.58408415877;42151;43025.78487107545;36566.26867462689;38706.225875482894;38731.22537549177;38914.80542597269;39130;28735.42529149447;28971.42057158887;29162;29263.268418288862;29372.412551748417 17:27:37 INFO - PROCESS | 25651 | |2;jquery.html;369.9482072509849;374.5991788786;375.4743359296985;385.2353079137909;401.68066387222154;17231.966082035087;19884.20463181473;19949.501262468446;20270.594588108248;20278.29025984091;18297.45107646773;18956.5260868478;18970.715439268388;19289.421317360466;19407.12667929943;5476.4249753775775;5553.7778488860595;5620.634658747189;5671.546276297886;5679.659220446786;5404.378496472917;5534.529564986981;5584.832455026335;5589.329280486327;5592.412796656354;5520.751566179511;5534.252875861767;5559.833205003856;5620.100783874581;5974.79088231912;5315.6013299002725;6039.486643635274;6067.423594758513;6080.543959203077;6120.877582448348;5440.945590544123;5541.972290138564;5559.6664200148125;5569.192467092289;5589.441055894378;11708.824367634492;12699.682507937283;12716.936415317956;12736.299503527302;12770.680732981657;2324.6280595104704;2383.5709572276983;2476.071473197551;2622.1609085092778;2740.342317843723;9579.13787759105;9740.805183896282;9769.169620582259;9855.704328870146;10088.293819432643;1819.0631824610336;1856.8885866848032;1969.5765410436682;1995.9401217963484;2078.9480262993393;78736.60631696862;81571.18428815695;82844.58577707133;85090.57454712749;85460.57269713611;10001.599936002624;10313.639022634172;10345.84481232767;10363;10461.529231184615;13902.51341203053;13958.720825583432;13996.72006559863;14118.647033824236;14134.78797818013;7748.922510774933;8057.556834374049;8142.959285203536;8168.197437057734;8168.346532277404;7903.328217101611;7968.087658961807;8011.919880801117;8210.343172546181;8229.547374894319;4333.58830911063;4401.735895846259;4415.933760993587;4463.174312752087;4509.210888094571;1815.3374018483423;1821.2805941652973;1844.5204246895635;1852.6109517001312;1897.098878032951;922.7416323429451;942.7030485397078;961.4375590279765;963.1764841060932;992.6873034993954;18588.44234672962;19482.707759383622;19657.7393599735;19788.802111978985;19880.801191988183;965.8261512927741;971.9454391984634;991.5141580625442;998.9750256243507;1010.525053224983;10638.574457021632;10648.680539583826;10877.0754485868;10912.781744365227;11004.834927476095;486887;499641;504005;504168;506192;59831;90434.54782726044;92257.53871230735;92932;94766;920.889493260813;936.6159874451442;956.2350119904049;962.8892677342055;966.9033096690275;16518.83481165173;16719.247633856263;16773.32906683768;17161.570960726083;17469.650606987536;40491.39262911118;41920;42358.36462453004;42383.7880810594;44171.11657766762;53097.734511327195;53187;55246;62482;62679.37320626918;7290.599017054113;7637.198094200029;7692.076950765944;8081.595920204084;8470.915290847013;9676.419414835133;12393.752124957631;13146.934265328613;13403.32983350809;13889.444422222998;11353.829692554784;11866.466009029442;12301.876981230072;12394.504219831106;12444.626661200178;10114.544845481823;10170.237232207763;11964.521419143137;12099.395030248628;12491.437885295001;12030.699232519257;12461.626151215478;12559.93720031394;12598.937005314914;12634.747305054032;8473.745787626382;8525.668412005913;8604.913950860411;8609.139086091342;8776.473411595325;8862.911370886466;11860.881391185978;11910.52357905674;11940.641780746591;12000.519979200733 17:27:37 INFO - PROCESS | 25651 | |3;mootools.html;1477.9113253204805;1504.082509669102;1616.2807550639964;1725.8619310455165;1745.720684690449;7661.233876612336;8326.167383261678;8353.582320883961;8837.469751814888;8999.100089990998;8411.873821892661;8609.784755381103;8611.224989750921;8654.653813847439;8664.74005779826;2245.38251980705;2261.570301642691;2279.0655831109248;2283.851549649276;2287.611106111965;2200.6919031335624;2217.4899773052207;2237.574860776447;2242.6411774116145;2242.921497747579;2190.9233176838816;2192.4299682082615;2200.5928903152967;2205.4155648753094;2222.944426389345;2132.552164045552;2149.8280137589036;2152.472644202173;2159.492519257973;2167.7181966344274;2177.1835561664375;2180.585688719154;2185.726784151981;2188.1684959715208;2188.7045248891354;8742.388032837704;8742.519161446118;8763.430377025474;8785.7803554911;8792.164744349277;4977.651564390494;5092.28707980883;5098.158803797369;5098.796048158069;5104.438511763703;2998.280412700958;3146.386454641346;3194.0577529628818;3205.7595680323834;3253.6258330292085;1087.2823936202149;1114.0586204657134;1123.5056575106926;1130.8416821644976;1137.744007598292;11861.584844530485;11945.581904633296;11954;12048.216865903776;12085.45615447307;4279.657627389802;4323.373110898902;4386.298192289219;4414.977925110418;4423.668224883147;10091.798164036678;10228.386296822215;10306.484675766182;10324.587016519405;10336.586536538605;5027.622928280393;5074.340335756402;5080.390353157571;5084.77118529667;5099.209622508517;4196.370544418301;4468.374427580141;4559.931601025987;4607.7004994675235;4612.054528821651;3747.9063023424087;3839.1745774658025;3845.250176215667;3866.38137897935;4024.2957482440456;1212.5028738217466;1217.8234156047324;1219.7682440336307;1224.9510019599115;1233.8272641830151;866.3935245328296;961.7884065505577;970.5292932927524;975.4293738163254;978.6574698855486;5839.065749480063;5855.560832937546;5928.377071892051;5981.461668449773;6066.939330606726;435.25136764764557;436.90169711815224;446.44640645599225;449.18472971557173;450.6034689473308;3923;3981.1042515434374;3989.5412027617194;4008.0981779100052;4034.5360283567766;10485.68542943713;10634.521446534924;10673.946630266799;10719.624813131659;10801.243912926177;10424.478776061167;10469.110125639407;10478.161747060218;10657.786844263226;10674.359538427563;8061.314788243065;8088.352931765445;8092.959535202286;8133.308668763103;8193.180681931879;5799.8550036249435;5819.388964158872;5874.295084589877;5936.525077993837;5944.1975333331175;9677.419354838732;9744.853827192455;9873.358231714916;9975.750606234611;10065.194784417083;9961.800763984824;10013;10033.749156271151;10045.949770251102;10174.593016279267;6856.5200435969;7572.924270757442;7856.685732570862;7872.464869350421;7878;8656.264217541328;8666.653333866574;8715.172058654418;8761.167689069529;8776.868346974928;7695.653695583824;7871.763847084597;7971.521708697497;7991.84016319682;8030.879536806836;7687.346575541142;7847.058352997677;7855.528668279693;7885.684572617031;7961.203879612224;7000.859982800213;7101.396381307647;7126.35862772353;7170.856582868418;7171.8565628688175;5188.09208388523;5221.4778522149;5286.048511267855;5300.734963251745;5339.7063161526485;5074.67014644047;5085.440601533903;5086.7710953007945;5231.163013917755;5252.317198764136 17:27:37 INFO - PROCESS | 25651 | |4;prototype.html;320.33050923569743;321.9581454410926;322.31829680226315;322.9321842413093;323.9206394433364;5599.636023658464;5667.0165442095295;5670.829875103748;5724.370319264877;5756.366799652035;5596.552275817935;5631.7184140793;5649.915251271234;5676.659400435967;5684.289463817023;4133.3386658134705;4193.329067349225;4318.330658747899;4337.240982828008;4372.169287835317;4320.969144502094;4351.8694439166875;4362.520122786491;4362.869113926571;4371.23503386906;4303.526612072669;4331.7400955942585;4341.9782901085455;4356;4385.758783266919;4212.726172798773;4237.9999999999845;4313.9137217255475;4316.287812510964;4357.564243575617;3783.6783873370796;3798.8480460781534;3800.992736924717;3818.236352729465;3823.7323387362894;5424.376196737387;5441.891162176774;5480.205370221335;5562.888742225133;5573.804916827932;4796.242160757543;4902.313676085351;4914.164592019365;4929.433115191727;4961.9751901240625;5757.88484230313;5765.798197063083;5781.8725348557045;5875.794347197828;5948.672822994734;4191.392248124035;4211.536730959592;4215.587778094342;4230.746155230696;4242.300020496646;5924.911126333109;6104.603200791934;6105.32841387447;6126.966558621246;6136.325004249574;4222.0289333453475;4251.851185208503;4254.574542545721;4262.339337402707;4269.530351661315;4267.594578515036;4273.35899615054;4294.420253265832;4298.376735373354;4331.350297455407;4791.880202994883;4893.755312234374;4946.604271658259;4948.084604348207;5004.499550044967;5826.523727415832;5839.708014599253;5888.793892213752;5902.704864756745;5931.4958228550195;1471.9190444525655;1500;1506.909585424856;1510.7054124445847;1519.8176218853807;935.9251259899191;959.5729900194347;974.9567962280433;979;986.1223511075149;5748.741306641211;5776.653400795965;5781;5787.536997040227;5798.536117110621;6033.698315084228;6045.972184728606;6053.152558641794;6057.303410107894;6107.62578419852;5540.418256083134;5659.463892264672;5688.601797874192;5691.658500489983;5718.285214348207;3188.8883889064236;3220.679521396263;3244.545763593099;3256.534559448258;3258.169166862435;6103.969480152571;6108.725107370179;6211.409916057967;6277.654728989949;6289.40250676185;6096.481799047131;6133;6160.767846430642;6175.912043978011;6224.408681175281;5995.15423708786;6257.217847769029;6267.965785645409;6269.279032911274;6310.968445157745;5949.910751338647;5995.940040599538;6001.879962400815;6030.819075427744;6066.878662426815;5839.591228613956;5916.467517923407;5953.618552579003;5983.970080149571;5996.730147143477;6032.341106195831;6144.804701555256;6166.81499555014;6210.844728881814;6277.309495955533;4155.501339839238;4188.392683061;4211.894702632459;4220.15596880619;4222.387753775747;6081.726322315418;6095.695215239131;6098.75604975796;6099.939000610115;6110.388961103854;5621.2411324472305;5841.1238314253205;5945.702714864153;5964.522838173022;5970.462658360769;5827.679477628772;5840.678762668094;5870.442307980735;5870.882582348244;5900.616459930091;5325.920111198413;5670.319561652463;5704.714764261853;5757.65454072757;5825.70871456434;5912.497437717842;5933.465988060922;5934.762609495572;5950.905529124917;5960.195373624505;5595.804146854841;5798.94201057984;5857.414258574279;5872.120921305313;5886.6173698709445 17:27:37 INFO - PROCESS | 25651 | |5;yui.html;784.6273020315348;807.5679511461368;821.9136990615989;829.4318391901546;850.391969741635;14560.708785824278;15898.602534936632;15919.92040039801;15987.440439584618;15995.600109997256;14446.277686115705;14886.776698349533;14945.701085978273;14955.252237388115;15022;796.760971708488;803.236924921327;810.3962547901822;810.7851419373841;812.8740045292959;805.4120492040814;807.8909347238107;808.6805711743858;811.0105671081271;813.0284310249255;837.5937670229933;838.9077201507829;839.3453106576849;841.0706169682504;845.5434065604566;825.145973916996;830.6469750356135;832.4214670803793;833.0919297965187;837.0123254559617;606.0848119339785;608.7443273825004;610.7099127914249;613.4969325153376;614.081947488503;16057.678846423123;16063.678726425524;16082.19589020556;16109.113998730065;16113.838861611352;14659;15258.694826103527;15610.843891561053;15907.60230994223;16017.759733603889;12642.304673242968;12769.936150319189;12879.162854414433;13087.149335293176;13260.204387736767;3953.9011524711823;3969.0871099646956;3976.1053762903116;4011.859584914543;4147.129102888397;64022.3597764021;64298;79219;79705;79994.60002700008;11430.828537571942;11491.988377330832;11699.88300117005;11731.381095341152;11849.22980006314;23458.413539661302;23528.764712353;23579.056837726297;23748.287551373487;23929.16247931314;9033.63865445388;9050.637974480947;9058.682946096855;9161.908380916106;9166.083391660914;4774.71351718891;4820.918151765977;4884.804607815719;4928.581070608967;4961.330220420197;3671.2473942841652;3807.7524960877454;3811.77129372233;3812.4090765931323;3814.256220037066;596.4661627843057;597.3220394851875;603.0953569645532;617.6942413505344;623.82844717703;714.9026244714443;750.3209595316248;753.8341564855723;758.2758465665277;772.7836205862368;10301.433421161759;10365.274430789772;10665.9466702666;10750.838737418944;11088.833667494993;635.7425242776683;695.8330000799873;729.3253740290317;738.9778306650809;752.5672738175571;4829.9275510867365;4897.951020489821;5224.164133738584;5258.71077090756;5310.468953104659;127297.36351318369;128804;130108.349458254;130305.34847325702;130526;108957;109695.45152274187;112398;112933.43533282445;113306;54945.23059094942;54968.72515637396;56719;89657.55171224102;89922.55038724764;10066.245031622804;10241.231907607109;10314.742131446474;10316.43259620728;10700.571977120828;47200.29199561941;49883.25175122449;52000.73999629977;52409.73795131;53198;67810.3218967804;70995.64502177456;76520.23479765354;76931.61534192294;77909.2209077902;13385.598432047054;13442.059055865995;13524.79712804289;13546.390412431267;13846.307684615931;15377.615559611098;15664.686706266039;15674.216289185722;15679.843201567839;15991.760123597922;13499.527516536875;13574.389152487964;13708.314584270547;14254.287285635884;14409.495667651581;13966.301684915918;14320.498782542561;14390.928045359706;14418.927905360406;14596.12423254608;12994.740105198032;14157.504487342894;14503.637409064435;14553.85446145525;14973.32620032123;11422.371769552423;11794.76410471803;11889.702757431134;11914.106442017057;12548.749025019632;12087.637370878887;12139.311433165969;12436.19164754288;12500.187487813264;12683.80974285368 17:27:37 INFO - PROCESS | 25651 | __end_tp_report 17:27:37 INFO - PROCESS | 25651 | __start_cc_report 17:27:37 INFO - PROCESS | 25651 | _x_x_mozilla_cycle_collect,353 17:27:37 INFO - PROCESS | 25651 | __end_cc_report 17:27:37 INFO - PROCESS | 25651 | __startTimestamp1467073657356__endTimestamp 17:27:37 INFO - PROCESS | 25651 | 17:27:37 INFO - PROCESS | 25651 | ------- Summary: start ------- 17:27:37 INFO - PROCESS | 25651 | Number of tests: 6 17:27:37 INFO - PROCESS | 25651 | 17:27:37 INFO - PROCESS | 25651 | [#0] dojo.html Cycles:165 Average:5350.50 Median:5623.21 stddev:706.67 (12.6%) stddev-sans-first:686.52 17:27:37 INFO - PROCESS | 25651 | Values: 3104.3 3118.1 3153.1 3167.8 3167.8 5289.7 5453.0 5469.5 5485.0 5501.3 5329.3 5372.9 5374.3 5379.5 5460.9 4840.6 4867.8 4951.8 5013.3 5060.3 797.6 4786.6 4829.6 4973.4 4998.2 4864.8 4890.4 4900.6 4914.6 4923.1 4892.4 4908.7 4913.0 4926.3 4954.9 4857.5 4874.6 4897.1 4945.4 4964.8 5394.2 5398.0 5448.0 5453.9 5461.8 5691.1 5784.7 5823.4 5838.6 5839.9 5755.7 5809.0 5832.3 5854.6 5879.3 5449.4 5471.6 5479.9 5481.3 5482.9 5801.8 5907.1 5933.5 5945.7 5958.1 5602.9 5667.6 5688.1 5711.7 5792.7 5771.6 5775.5 5781.2 5782.1 5791.2 5633.3 5681.6 5729.0 5737.9 5742.0 5709.0 5744.5 5780.1 5806.2 5831.1 4400.2 4402.3 4422.1 4453.2 4454.6 3909.6 3929.5 3961.7 3976.2 4017.1 5487.2 5506.5 5517.6 5572.2 5611.1 5771.9 5780.2 5783.0 5802.2 5810.7 5429.8 5482.1 5491.5 5523.8 5533.2 4867.5 4883.4 4889.1 4922.1 4929.5 6022.4 6028.3 6028.3 6038.7 6050.5 5652.7 5709.7 5710.8 5750.1 5833.2 5986.7 5995.7 6025.0 6031.8 6035.8 5653.6 5670.9 5671.9 5676.7 5743.6 5641.7 5736.2 5769.5 5805.6 5836.7 5690.5 5710.6 5725.6 5726.7 5736.6 5509.6 5639.6 5684.5 5692.4 5699.5 5432.0 5440.6 5470.3 5497.3 5530.4 5623.2 5666.5 5693.1 5750.8 5755.9 5421.2 5633.6 5651.5 5653.3 5660.1 17:27:37 INFO - PROCESS | 25651 | 17:27:37 INFO - PROCESS | 25651 | [#1] ext.html Cycles:180 Average:64048.90 Median:42377.86 stddev:134547.22 (317.5%) stddev-sans-first:134840.21 17:27:37 INFO - PROCESS | 25651 | Values: 555.9 596.1 615.2 615.5 617.8 42385.4 43627.8 43728.8 43759.8 47561.0 45639.0 45687.3 46025.8 46127.3 46331.5 8648.8 8806.8 8825.3 8835.5 8857.2 8804.2 8893.2 8895.3 8897.8 8898.9 8858.5 8878.0 8896.4 8902.5 8958.5 8833.4 8838.7 8842.6 8871.2 8877.8 8630.1 8660.1 8688.9 8715.6 8718.0 42335.0 42412.0 43028.4 43082.6 43151.4 3389.8 3486.9 3515.6 3608.1 3651.3 33224.3 33373.7 33699.0 34842.7 34948.8 4374.9 4413.9 4436.2 4558.5 4625.9 364307.0 367335.0 367436.0 368310.0 369908.0 34643.7 61661.7 62459.4 62487.7 62549.4 35089.6 36513.6 36723.3 36732.6 36806.3 15205.5 15305.3 15310.7 15327.3 15358.5 11922.7 11941.5 11965.7 11984.6 12062.3 8351.7 8366.5 8405.6 8435.7 8494.2 3244.0 3248.6 3274.1 3278.6 3281.4 952.7 1030.4 1037.4 1124.5 1127.8 31801.7 31977.8 32003.7 32241.5 32669.7 1084.4 1097.2 1116.8 1175.4 1185.2 16454.9 17424.9 18053.3 18890.5 19023.2 613851.0 618360.0 621656.0 621925.0 621945.0 59262.7 60842.4 60978.4 61037.4 61157.1 1374.8 1388.4 1412.8 1421.8 1428.4 31983.8 33793.5 34275.0 34359.8 34647.5 52930.0 53001.7 53038.0 53747.5 53850.2 492222.0 494010.0 494561.0 494876.0 495876.0 26012.7 26568.2 26614.7 28473.6 28803.3 50147.1 50380.7 50669.2 50813.0 51448.0 40324.2 42122.4 42686.1 43215.4 43326.8 41772.8 41902.0 42188.6 42370.4 42898.0 37235.0 41529.4 41591.6 42151.0 43025.8 36566.3 38706.2 38731.2 38914.8 39130.0 28735.4 28971.4 29162.0 29263.3 29372.4 17:27:37 INFO - PROCESS | 25651 | 17:27:37 INFO - PROCESS | 25651 | [#2] jquery.html Cycles:180 Average:28762.98 Median:4408.83 stddev:82426.74 (1869.6%) stddev-sans-first:82630.39 17:27:37 INFO - PROCESS | 25651 | Values: 369.9 374.6 375.5 385.2 401.7 17232.0 19884.2 19949.5 20270.6 20278.3 18297.5 18956.5 18970.7 19289.4 19407.1 5476.4 5553.8 5620.6 5671.5 5679.7 5404.4 5534.5 5584.8 5589.3 5592.4 5520.8 5534.3 5559.8 5620.1 5974.8 5315.6 6039.5 6067.4 6080.5 6120.9 5440.9 5542.0 5559.7 5569.2 5589.4 11708.8 12699.7 12716.9 12736.3 12770.7 2324.6 2383.6 2476.1 2622.2 2740.3 9579.1 9740.8 9769.2 9855.7 10088.3 1819.1 1856.9 1969.6 1995.9 2078.9 78736.6 81571.2 82844.6 85090.6 85460.6 10001.6 10313.6 10345.8 10363.0 10461.5 13902.5 13958.7 13996.7 14118.6 14134.8 7748.9 8057.6 8143.0 8168.2 8168.3 7903.3 7968.1 8011.9 8210.3 8229.5 4333.6 4401.7 4415.9 4463.2 4509.2 1815.3 1821.3 1844.5 1852.6 1897.1 922.7 942.7 961.4 963.2 992.7 18588.4 19482.7 19657.7 19788.8 19880.8 965.8 971.9 991.5 999.0 1010.5 10638.6 10648.7 10877.1 10912.8 11004.8 486887.0 499641.0 504005.0 504168.0 506192.0 59831.0 90434.5 92257.5 92932.0 94766.0 920.9 936.6 956.2 962.9 966.9 16518.8 16719.2 16773.3 17161.6 17469.7 40491.4 41920.0 42358.4 42383.8 44171.1 53097.7 53187.0 55246.0 62482.0 62679.4 7290.6 7637.2 7692.1 8081.6 8470.9 9676.4 12393.8 13146.9 13403.3 13889.4 11353.8 11866.5 12301.9 12394.5 12444.6 10114.5 10170.2 11964.5 12099.4 12491.4 12030.7 12461.6 12559.9 12598.9 12634.7 8473.7 8525.7 8604.9 8609.1 8776.5 8862.9 11860.9 11910.5 11940.6 12000.5 17:27:37 INFO - PROCESS | 25651 | 17:27:37 INFO - PROCESS | 25651 | [#3] mootools.html Cycles:180 Average:5696.62 Median:449.89 stddev:3286.36 (730.5%) stddev-sans-first:3280.29 17:27:37 INFO - PROCESS | 25651 | Values: 1477.9 1504.1 1616.3 1725.9 1745.7 7661.2 8326.2 8353.6 8837.5 8999.1 8411.9 8609.8 8611.2 8654.7 8664.7 2245.4 2261.6 2279.1 2283.9 2287.6 2200.7 2217.5 2237.6 2242.6 2242.9 2190.9 2192.4 2200.6 2205.4 2222.9 2132.6 2149.8 2152.5 2159.5 2167.7 2177.2 2180.6 2185.7 2188.2 2188.7 8742.4 8742.5 8763.4 8785.8 8792.2 4977.7 5092.3 5098.2 5098.8 5104.4 2998.3 3146.4 3194.1 3205.8 3253.6 1087.3 1114.1 1123.5 1130.8 1137.7 11861.6 11945.6 11954.0 12048.2 12085.5 4279.7 4323.4 4386.3 4415.0 4423.7 10091.8 10228.4 10306.5 10324.6 10336.6 5027.6 5074.3 5080.4 5084.8 5099.2 4196.4 4468.4 4559.9 4607.7 4612.1 3747.9 3839.2 3845.3 3866.4 4024.3 1212.5 1217.8 1219.8 1225.0 1233.8 866.4 961.8 970.5 975.4 978.7 5839.1 5855.6 5928.4 5981.5 6066.9 435.3 436.9 446.4 449.2 450.6 3923.0 3981.1 3989.5 4008.1 4034.5 10485.7 10634.5 10673.9 10719.6 10801.2 10424.5 10469.1 10478.2 10657.8 10674.4 8061.3 8088.4 8093.0 8133.3 8193.2 5799.9 5819.4 5874.3 5936.5 5944.2 9677.4 9744.9 9873.4 9975.8 10065.2 9961.8 10013.0 10033.7 10045.9 10174.6 6856.5 7572.9 7856.7 7872.5 7878.0 8656.3 8666.7 8715.2 8761.2 8776.9 7695.7 7871.8 7971.5 7991.8 8030.9 7687.3 7847.1 7855.5 7885.7 7961.2 7000.9 7101.4 7126.4 7170.9 7171.9 5188.1 5221.5 5286.0 5300.7 5339.7 5074.7 5085.4 5086.8 5231.2 5252.3 17:27:37 INFO - PROCESS | 25651 | 17:27:37 INFO - PROCESS | 25651 | [#4] prototype.html Cycles:180 Average:4941.44 Median:5698.19 stddev:1469.05 (25.8%) stddev-sans-first:1431.64 17:27:37 INFO - PROCESS | 25651 | Values: 320.3 322.0 322.3 322.9 323.9 5599.6 5667.0 5670.8 5724.4 5756.4 5596.6 5631.7 5649.9 5676.7 5684.3 4133.3 4193.3 4318.3 4337.2 4372.2 4321.0 4351.9 4362.5 4362.9 4371.2 4303.5 4331.7 4342.0 4356.0 4385.8 4212.7 4238.0 4313.9 4316.3 4357.6 3783.7 3798.8 3801.0 3818.2 3823.7 5424.4 5441.9 5480.2 5562.9 5573.8 4796.2 4902.3 4914.2 4929.4 4962.0 5757.9 5765.8 5781.9 5875.8 5948.7 4191.4 4211.5 4215.6 4230.7 4242.3 5924.9 6104.6 6105.3 6127.0 6136.3 4222.0 4251.9 4254.6 4262.3 4269.5 4267.6 4273.4 4294.4 4298.4 4331.4 4791.9 4893.8 4946.6 4948.1 5004.5 5826.5 5839.7 5888.8 5902.7 5931.5 1471.9 1500.0 1506.9 1510.7 1519.8 935.9 959.6 975.0 979.0 986.1 5748.7 5776.7 5781.0 5787.5 5798.5 6033.7 6046.0 6053.2 6057.3 6107.6 5540.4 5659.5 5688.6 5691.7 5718.3 3188.9 3220.7 3244.5 3256.5 3258.2 6104.0 6108.7 6211.4 6277.7 6289.4 6096.5 6133.0 6160.8 6175.9 6224.4 5995.2 6257.2 6268.0 6269.3 6311.0 5949.9 5995.9 6001.9 6030.8 6066.9 5839.6 5916.5 5953.6 5984.0 5996.7 6032.3 6144.8 6166.8 6210.8 6277.3 4155.5 4188.4 4211.9 4220.2 4222.4 6081.7 6095.7 6098.8 6099.9 6110.4 5621.2 5841.1 5945.7 5964.5 5970.5 5827.7 5840.7 5870.4 5870.9 5900.6 5325.9 5670.3 5704.7 5757.7 5825.7 5912.5 5933.5 5934.8 5950.9 5960.2 5595.8 5798.9 5857.4 5872.1 5886.6 17:27:37 INFO - PROCESS | 25651 | 17:27:37 INFO - PROCESS | 25651 | [#5] yui.html Cycles:180 Average:21373.20 Median:3739.50 stddev:31220.54 (834.9%) stddev-sans-first:31269.85 17:27:37 INFO - PROCESS | 25651 | Values: 784.6 807.6 821.9 829.4 850.4 14560.7 15898.6 15919.9 15987.4 15995.6 14446.3 14886.8 14945.7 14955.3 15022.0 796.8 803.2 810.4 810.8 812.9 805.4 807.9 808.7 811.0 813.0 837.6 838.9 839.3 841.1 845.5 825.1 830.6 832.4 833.1 837.0 606.1 608.7 610.7 613.5 614.1 16057.7 16063.7 16082.2 16109.1 16113.8 14659.0 15258.7 15610.8 15907.6 16017.8 12642.3 12769.9 12879.2 13087.1 13260.2 3953.9 3969.1 3976.1 4011.9 4147.1 64022.4 64298.0 79219.0 79705.0 79994.6 11430.8 11492.0 11699.9 11731.4 11849.2 23458.4 23528.8 23579.1 23748.3 23929.2 9033.6 9050.6 9058.7 9161.9 9166.1 4774.7 4820.9 4884.8 4928.6 4961.3 3671.2 3807.8 3811.8 3812.4 3814.3 596.5 597.3 603.1 617.7 623.8 714.9 750.3 753.8 758.3 772.8 10301.4 10365.3 10665.9 10750.8 11088.8 635.7 695.8 729.3 739.0 752.6 4829.9 4898.0 5224.2 5258.7 5310.5 127297.4 128804.0 130108.3 130305.3 130526.0 108957.0 109695.5 112398.0 112933.4 113306.0 54945.2 54968.7 56719.0 89657.6 89922.6 10066.2 10241.2 10314.7 10316.4 10700.6 47200.3 49883.3 52000.7 52409.7 53198.0 67810.3 70995.6 76520.2 76931.6 77909.2 13385.6 13442.1 13524.8 13546.4 13846.3 15377.6 15664.7 15674.2 15679.8 15991.8 13499.5 13574.4 13708.3 14254.3 14409.5 13966.3 14320.5 14390.9 14418.9 14596.1 12994.7 14157.5 14503.6 14553.9 14973.3 11422.4 11794.8 11889.7 11914.1 12548.7 12087.6 12139.3 12436.2 12500.2 12683.8 17:27:37 INFO - PROCESS | 25651 | -------- Summary: end -------- 17:27:37 INFO - PROCESS | 25651 | 17:27:38 INFO - TEST-INFO | 25651: exit 0 17:27:38 INFO - TEST-OK | dromaeo_css | took 1111530ms 17:27:38 INFO - TEST-START | kraken 17:27:38 INFO - operating with platform_type : linux_ 17:27:38 INFO - Initialising browser for kraken test... 17:27:38 INFO - TEST-INFO | started process 25889 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe2DRho/profile http://localhost:54435/getInfo.html) 17:27:42 INFO - PROCESS | 25889 | __metrics Screen width/height:1600/1200 17:27:42 INFO - PROCESS | 25889 | colorDepth:24 17:27:42 INFO - PROCESS | 25889 | Browser inner width/height: 1024/697 17:27:42 INFO - PROCESS | 25889 | __metrics 17:27:43 ERROR - PROCESS | 25889 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 17:27:44 INFO - TEST-INFO | 25889: exit 0 17:27:44 INFO - Browser initialized. 17:27:44 INFO - Running cycle 1/1 for kraken test... 17:27:44 INFO - TEST-INFO | started process 26008 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe2DRho/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:27:56 INFO - PROCESS | 26008 | RSS: Main: 185323520 17:27:56 INFO - PROCESS | 26008 | 17:27:58 INFO - PROCESS | 26008 | Cycle 1(1): loaded http://localhost:54435/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54435/tests/kraken/driver.html?testName=audio-beat-detection) 17:27:59 INFO - PROCESS | 26008 | RSS: Main: 190832640 17:27:59 INFO - PROCESS | 26008 | 17:28:02 INFO - PROCESS | 26008 | Cycle 1(1): loaded http://localhost:54435/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54435/tests/kraken/driver.html?testName=audio-dft) 17:28:03 INFO - PROCESS | 26008 | RSS: Main: 189706240 17:28:03 INFO - PROCESS | 26008 | 17:28:05 INFO - PROCESS | 26008 | Cycle 1(1): loaded http://localhost:54435/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54435/tests/kraken/driver.html?testName=audio-fft) 17:28:06 INFO - PROCESS | 26008 | RSS: Main: 184512512 17:28:06 INFO - PROCESS | 26008 | 17:28:08 INFO - PROCESS | 26008 | Cycle 1(1): loaded http://localhost:54435/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54435/tests/kraken/driver.html?testName=audio-oscillator) 17:28:09 INFO - PROCESS | 26008 | RSS: Main: 185438208 17:28:09 INFO - PROCESS | 26008 | 17:28:11 INFO - PROCESS | 26008 | Cycle 1(1): loaded http://localhost:54435/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54435/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:28:12 INFO - PROCESS | 26008 | RSS: Main: 186228736 17:28:12 INFO - PROCESS | 26008 | 17:28:15 INFO - PROCESS | 26008 | Cycle 1(1): loaded http://localhost:54435/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54435/tests/kraken/driver.html?testName=imaging-darkroom) 17:28:15 INFO - PROCESS | 26008 | RSS: Main: 185991168 17:28:15 INFO - PROCESS | 26008 | 17:28:19 INFO - PROCESS | 26008 | Cycle 1(1): loaded http://localhost:54435/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54435/tests/kraken/driver.html?testName=imaging-desaturate) 17:28:19 INFO - PROCESS | 26008 | RSS: Main: 186654720 17:28:19 INFO - PROCESS | 26008 | 17:28:22 INFO - PROCESS | 26008 | Cycle 1(1): loaded http://localhost:54435/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54435/tests/kraken/driver.html?testName=json-parse-financial) 17:28:23 INFO - PROCESS | 26008 | RSS: Main: 186253312 17:28:23 INFO - PROCESS | 26008 | 17:28:24 INFO - PROCESS | 26008 | Cycle 1(1): loaded http://localhost:54435/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54435/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:28:25 INFO - PROCESS | 26008 | RSS: Main: 186359808 17:28:25 INFO - PROCESS | 26008 | 17:28:27 INFO - PROCESS | 26008 | Cycle 1(1): loaded http://localhost:54435/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54435/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:28:27 INFO - PROCESS | 26008 | RSS: Main: 186392576 17:28:27 INFO - PROCESS | 26008 | 17:28:30 INFO - PROCESS | 26008 | Cycle 1(1): loaded http://localhost:54435/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54435/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:28:30 INFO - PROCESS | 26008 | RSS: Main: 186806272 17:28:30 INFO - PROCESS | 26008 | 17:28:33 INFO - PROCESS | 26008 | Cycle 1(1): loaded http://localhost:54435/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54435/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:28:33 INFO - PROCESS | 26008 | RSS: Main: 186953728 17:28:33 INFO - PROCESS | 26008 | 17:28:36 INFO - PROCESS | 26008 | Cycle 1(1): loaded http://localhost:54435/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54435/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:28:37 INFO - PROCESS | 26008 | RSS: Main: 186875904 17:28:37 INFO - PROCESS | 26008 | 17:28:38 INFO - PROCESS | 26008 | Cycle 1(1): loaded http://localhost:54435/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54435/tests/kraken/driver.html?testName=ai-astar) 17:28:39 INFO - PROCESS | 26008 | RSS: Main: 187547648 17:28:39 INFO - PROCESS | 26008 | 17:28:39 INFO - PROCESS | 26008 | __start_tp_report 17:28:39 INFO - PROCESS | 26008 | _x_x_mozilla_page_load 17:28:39 INFO - PROCESS | 26008 | _x_x_mozilla_page_load_details 17:28:39 INFO - PROCESS | 26008 | |i|pagename|runs| 17:28:39 INFO - PROCESS | 26008 | |0;ai-astar;103;110;106;111;116;112;111;109;112;112 17:28:39 INFO - PROCESS | 26008 | |1;audio-beat-detection;156;126;155;178;128;159;153;137;185;126 17:28:39 INFO - PROCESS | 26008 | |2;audio-dft;162;162;162;163;165;173;165;162;162;160 17:28:39 INFO - PROCESS | 26008 | |3;audio-fft;76;75;74;162;77;76;75;74;167;84 17:28:39 INFO - PROCESS | 26008 | |4;audio-oscillator;85;85;149;85;85;87;146;86;86;137 17:28:39 INFO - PROCESS | 26008 | |5;imaging-gaussian-blur;118;118;118;116;119;117;117;118;119;118 17:28:39 INFO - PROCESS | 26008 | |6;imaging-darkroom;147;149;146;147;147;146;146;149;150;149 17:28:39 INFO - PROCESS | 26008 | |7;imaging-desaturate;95;98;95;95;95;95;96;96;96;96 17:28:39 INFO - PROCESS | 26008 | |8;json-parse-financial;54;58;53;55;55;54;54;55;54;55 17:28:39 INFO - PROCESS | 26008 | |9;json-stringify-tinderbox;64;61;61;62;61;60;61;65;62;62 17:28:39 INFO - PROCESS | 26008 | |10;stanford-crypto-aes;79;78;82;85;80;80;81;84;99;81 17:28:39 INFO - PROCESS | 26008 | |11;stanford-crypto-ccm;140;132;133;129;121;125;122;138;134;124 17:28:39 INFO - PROCESS | 26008 | |12;stanford-crypto-pbkdf2;158;158;162;159;158;157;163;160;166;158 17:28:39 INFO - PROCESS | 26008 | |13;stanford-crypto-sha256-iterative;62;62;62;70;65;62;61;63;61;68 17:28:39 INFO - PROCESS | 26008 | __end_tp_report 17:28:39 INFO - PROCESS | 26008 | __start_cc_report 17:28:39 INFO - PROCESS | 26008 | _x_x_mozilla_cycle_collect,901 17:28:39 INFO - PROCESS | 26008 | __end_cc_report 17:28:39 INFO - PROCESS | 26008 | __startTimestamp1467073719176__endTimestamp 17:28:39 INFO - PROCESS | 26008 | 17:28:39 INFO - PROCESS | 26008 | ------- Summary: start ------- 17:28:39 INFO - PROCESS | 26008 | Number of tests: 14 17:28:39 INFO - PROCESS | 26008 | 17:28:39 INFO - PROCESS | 26008 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.50 stddev:3.58 (3.2%) stddev-sans-first:2.69 17:28:39 INFO - PROCESS | 26008 | Values: 103.0 110.0 106.0 111.0 116.0 112.0 111.0 109.0 112.0 112.0 17:28:39 INFO - PROCESS | 26008 | 17:28:39 INFO - PROCESS | 26008 | [#1] audio-beat-detection Cycles:10 Average:150.30 Median:155.50 stddev:20.99 (13.5%) stddev-sans-first:22.16 17:28:39 INFO - PROCESS | 26008 | Values: 156.0 126.0 155.0 178.0 128.0 159.0 153.0 137.0 185.0 126.0 17:28:39 INFO - PROCESS | 26008 | 17:28:39 INFO - PROCESS | 26008 | [#2] audio-dft Cycles:10 Average:163.60 Median:162.50 stddev:3.63 (2.2%) stddev-sans-first:3.80 17:28:39 INFO - PROCESS | 26008 | Values: 162.0 162.0 162.0 163.0 165.0 173.0 165.0 162.0 162.0 160.0 17:28:39 INFO - PROCESS | 26008 | 17:28:39 INFO - PROCESS | 26008 | [#3] audio-fft Cycles:10 Average:94.00 Median:75.50 stddev:37.29 (49.4%) stddev-sans-first:38.97 17:28:39 INFO - PROCESS | 26008 | Values: 76.0 75.0 74.0 162.0 77.0 76.0 75.0 74.0 167.0 84.0 17:28:39 INFO - PROCESS | 26008 | 17:28:39 INFO - PROCESS | 26008 | [#4] audio-oscillator Cycles:10 Average:103.10 Median:85.00 stddev:28.38 (33.4%) stddev-sans-first:29.34 17:28:39 INFO - PROCESS | 26008 | Values: 85.0 85.0 149.0 85.0 85.0 87.0 146.0 86.0 86.0 137.0 17:28:39 INFO - PROCESS | 26008 | 17:28:39 INFO - PROCESS | 26008 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.92 (0.8%) stddev-sans-first:0.97 17:28:39 INFO - PROCESS | 26008 | Values: 118.0 118.0 118.0 116.0 119.0 117.0 117.0 118.0 119.0 118.0 17:28:39 INFO - PROCESS | 26008 | 17:28:39 INFO - PROCESS | 26008 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:1.51 (1.0%) stddev-sans-first:1.58 17:28:39 INFO - PROCESS | 26008 | Values: 147.0 149.0 146.0 147.0 147.0 146.0 146.0 149.0 150.0 149.0 17:28:39 INFO - PROCESS | 26008 | 17:28:39 INFO - PROCESS | 26008 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.95 (1.0%) stddev-sans-first:0.97 17:28:39 INFO - PROCESS | 26008 | Values: 95.0 98.0 95.0 95.0 95.0 95.0 96.0 96.0 96.0 96.0 17:28:39 INFO - PROCESS | 26008 | 17:28:39 INFO - PROCESS | 26008 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:55.00 stddev:1.34 (2.4%) stddev-sans-first:1.39 17:28:39 INFO - PROCESS | 26008 | Values: 54.0 58.0 53.0 55.0 55.0 54.0 54.0 55.0 54.0 55.0 17:28:39 INFO - PROCESS | 26008 | 17:28:39 INFO - PROCESS | 26008 | [#9] json-stringify-tinderbox Cycles:10 Average:61.90 Median:62.00 stddev:1.52 (2.5%) stddev-sans-first:1.41 17:28:39 INFO - PROCESS | 26008 | Values: 64.0 61.0 61.0 62.0 61.0 60.0 61.0 65.0 62.0 62.0 17:28:39 INFO - PROCESS | 26008 | 17:28:39 INFO - PROCESS | 26008 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:81.50 stddev:6.05 (7.4%) stddev-sans-first:6.24 17:28:39 INFO - PROCESS | 26008 | Values: 79.0 78.0 82.0 85.0 80.0 80.0 81.0 84.0 99.0 81.0 17:28:39 INFO - PROCESS | 26008 | 17:28:39 INFO - PROCESS | 26008 | [#11] stanford-crypto-ccm Cycles:10 Average:129.80 Median:132.50 stddev:6.66 (5.0%) stddev-sans-first:5.96 17:28:39 INFO - PROCESS | 26008 | Values: 140.0 132.0 133.0 129.0 121.0 125.0 122.0 138.0 134.0 124.0 17:28:39 INFO - PROCESS | 26008 | 17:28:39 INFO - PROCESS | 26008 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.90 Median:159.50 stddev:2.88 (1.8%) stddev-sans-first:2.98 17:28:39 INFO - PROCESS | 26008 | Values: 158.0 158.0 162.0 159.0 158.0 157.0 163.0 160.0 166.0 158.0 17:28:39 INFO - PROCESS | 26008 | 17:28:39 INFO - PROCESS | 26008 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:62.50 stddev:3.10 (5.0%) stddev-sans-first:3.23 17:28:39 INFO - PROCESS | 26008 | Values: 62.0 62.0 62.0 70.0 65.0 62.0 61.0 63.0 61.0 68.0 17:28:39 INFO - PROCESS | 26008 | -------- Summary: end -------- 17:28:39 INFO - PROCESS | 26008 | 17:28:40 INFO - TEST-INFO | 26008: exit 0 17:28:40 INFO - TEST-OK | kraken | took 62082ms 17:28:40 INFO - SUITE-END | took 1173s 17:28:40 INFO - Completed test suite (00:19:33) 17:28:40 INFO - javascript benchmark 17:28:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7228.302897700915, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3104.3480869017503, 3118.080166350929, 3153.0698443959036, 3167.778255522113, 3167.8416079196036, 5289.735513224337, 5452.972735136329, 5469.480399362059, 5484.972575137129, 5501.284832971708, 5329.280547126137, 5372.91940620891, 5374.328208973879, 5379.515843574078, 5460.918086228709, 4840.6127509799135, 4867.756612169377, 4951.801927922878, 5013.298138260647, 5060.291559181717, 797.6432278194953, 4786.641001924852, 4829.589484893788, 4973.403191617011, 4998.150314446553, 4864.805407783684, 4890.437599676029, 4900.607951363918, 4914.606831453475, 4923.138450771101, 4892.437369702494, 4908.656394052417, 4913.041956818422, 4926.261060840867, 4954.9009019819405, 4857.489963553811, 4874.561289483928, 4897.069556784235, 4945.381827271591, 4964.776585053682, 5394.244805727201, 5398.0, 5447.972760136214, 5453.890922181534, 5461.836144915659, 5691.117876729114, 5784.739686714108, 5823.4467725566, 5838.649681019152, 5839.883202335972, 5755.712214389306, 5809.04150815115, 5832.329282132567, 5854.560907931879, 5879.265091863517, 5449.427810079924, 5471.5896307776675, 5479.917801233025, 5481.314835645544, 5482.91775623366, 5801.796937107181, 5907.084401917709, 5933.495652869468, 5945.732442040118, 5958.076498142795, 5602.887942241132, 5667.631603945731, 5688.06146985751, 5711.742971566289, 5792.652440853562, 5771.567132465082, 5775.480206781326, 5781.219535362757, 5782.132680097935, 5791.247137872134, 5633.295838020247, 5681.57388195887, 5728.971355143198, 5737.942620573825, 5742.0, 5709.0, 5744.4829965303325, 5780.132980053026, 5806.2451881255165, 5831.096180092092, 4400.207962566768, 4402.273624851928, 4422.115576884636, 4453.198424283595, 4454.57681520255, 3909.58949310324, 3929.5088113985753, 3961.6830653547645, 3976.224636195914, 4017.0760725033406, 5487.176923461513, 5506.504414602705, 5517.613767036269, 5572.247746554244, 5611.074172761449, 5771.8557036074435, 5780.1907732917425, 5783.0, 5802.187693722883, 5810.709464526757, 5429.755660995264, 5482.068048431776, 5491.533219676292, 5523.751431185526, 5533.1976863354585, 4867.5132486751045, 4883.3651625288485, 4889.071076495455, 4922.064807686528, 4929.507049295042, 6022.427869352405, 6028.2766068072115, 6028.306744724413, 6038.701679139006, 6050.515958723292, 5652.717364131695, 5709.714514274353, 5710.828675139753, 5750.137479378127, 5833.183354330397, 5986.700664966647, 5995.700214989321, 6025.0, 6031.849203769941, 6035.849103772265, 5653.632513886584, 5670.886582268249, 5671.886562268649, 5676.68778217202, 5743.59794814359, 5641.746121424464, 5736.196932429547, 5769.451902069297, 5805.564582656402, 5836.708164591669, 5690.5163061140265, 5710.600257981901, 5725.599208055396, 5726.65640061581, 5736.569757268138, 5509.614326997072, 5639.605227634026, 5684.48839604421, 5692.402297758841, 5699.458551437607, 5432.049391356576, 5440.646357986719, 5470.343558772973, 5497.312835895513, 5530.364008138955, 5623.2127502148915, 5666.46168613981, 5693.089105743061, 5750.827475175752, 5755.942440575541, 5421.241026256248, 5633.605647604629, 5651.519620832275, 5653.293338332708, 5660.066089095253], "value": 5304.552182274451, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.8721494056367, 596.0998891673573, 615.200239688405, 615.4553220399947, 617.8053913017401, 42385.36421953673, 43627.78186109073, 43728.78135609321, 43759.78120109399, 47561.0, 45639.0, 45687.31469027967, 46025.76987115068, 46127.30809037867, 46331.536684633145, 8648.783780405493, 8806.779830504225, 8825.293976481866, 8835.514046727427, 8857.158569935846, 8804.20762131408, 8893.244074253696, 8895.33285003624, 8897.77755556113, 8898.911010889906, 8858.512781796999, 8878.0, 8896.421732587361, 8902.510361930092, 8958.462492250454, 8833.425827321236, 8838.69064582743, 8842.557872106401, 8871.157240062184, 8877.778055548599, 8630.050694423608, 8660.090690477535, 8688.869666955, 8715.564221788949, 8718.0, 42335.0, 42412.0, 43028.35457468109, 43082.56917430817, 43151.35272970908, 3389.762716609838, 3486.9476957845654, 3515.6132825389186, 3608.1187664107338, 3651.3427583035045, 33224.335513289596, 33373.66626333754, 33699.0, 34842.651573484196, 34948.825255873555, 4374.8906277343, 4413.889652758707, 4436.179306828247, 4558.544145585448, 4625.930611040837, 364307.0, 367335.0, 367436.0, 368310.0, 369908.0, 34643.65356346455, 61661.69169154126, 62459.37540624626, 62487.6875615619, 62549.37450625526, 35089.64910350864, 36513.634863651554, 36723.26553468969, 36732.632673673455, 36806.263874722354, 15205.467808626645, 15305.311260993281, 15310.693786124215, 15327.31027103783, 15358.539243822703, 11922.701932451759, 11941.462634181482, 11965.700857478458, 11984.58053968107, 12062.276263424223, 8351.665933362598, 8366.498010119412, 8405.579721014046, 8435.662573497115, 8494.150584941457, 3244.0, 3248.561444205002, 3274.1159886830897, 3278.639349671534, 3281.392942305681, 952.6808519146025, 1030.350878946274, 1037.3931250218707, 1124.527698366688, 1127.7594645889455, 31801.681983180333, 31977.840110799298, 32003.679963200535, 32241.51637725436, 32669.67330326714, 1084.4089970965842, 1097.1880808201872, 1116.810142275815, 1175.3653027365299, 1185.17038073349, 16454.917725411295, 17424.91287543554, 18053.27786888536, 18890.527736806416, 19023.239070437303, 613851.0, 618360.0, 621656.0, 621925.0, 621945.0, 59262.70368648216, 60842.391576083675, 60978.39021609727, 61037.38962610406, 61157.08264376038, 1374.7594171020032, 1388.430743395203, 1412.7810189420657, 1421.8435972043067, 1428.4143501164472, 31983.840080799448, 33793.49309760307, 34275.0, 34359.828200858836, 34647.4802877952, 52930.0, 53001.734991324796, 53038.0, 53747.46252537581, 53850.192247117106, 492222.0, 494010.0, 494561.0, 494876.0, 495876.0, 26012.739872601032, 26568.202953911412, 26614.733852661226, 28473.572896406986, 28803.27991800222, 50147.11832909598, 50380.74809625928, 50669.23996140135, 50813.0, 51448.0, 40324.1935161301, 42122.36816447817, 42686.146277074906, 43215.35176972285, 43326.78336608297, 41772.79113604413, 41902.0, 42188.578114219694, 42370.36444453274, 42898.0, 37235.0, 41529.37705934474, 41591.58408415877, 42151.0, 43025.78487107545, 36566.26867462689, 38706.225875482894, 38731.22537549177, 38914.80542597269, 39130.0, 28735.42529149447, 28971.42057158887, 29162.0, 29263.268418288862, 29372.412551748417], "value": 19357.413906704947, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.9482072509849, 374.5991788786, 375.4743359296985, 385.2353079137909, 401.68066387222154, 17231.966082035087, 19884.20463181473, 19949.501262468446, 20270.594588108248, 20278.29025984091, 18297.45107646773, 18956.5260868478, 18970.715439268388, 19289.421317360466, 19407.12667929943, 5476.4249753775775, 5553.7778488860595, 5620.634658747189, 5671.546276297886, 5679.659220446786, 5404.378496472917, 5534.529564986981, 5584.832455026335, 5589.329280486327, 5592.412796656354, 5520.751566179511, 5534.252875861767, 5559.833205003856, 5620.100783874581, 5974.79088231912, 5315.6013299002725, 6039.486643635274, 6067.423594758513, 6080.543959203077, 6120.877582448348, 5440.945590544123, 5541.972290138564, 5559.6664200148125, 5569.192467092289, 5589.441055894378, 11708.824367634492, 12699.682507937283, 12716.936415317956, 12736.299503527302, 12770.680732981657, 2324.6280595104704, 2383.5709572276983, 2476.071473197551, 2622.1609085092778, 2740.342317843723, 9579.13787759105, 9740.805183896282, 9769.169620582259, 9855.704328870146, 10088.293819432643, 1819.0631824610336, 1856.8885866848032, 1969.5765410436682, 1995.9401217963484, 2078.9480262993393, 78736.60631696862, 81571.18428815695, 82844.58577707133, 85090.57454712749, 85460.57269713611, 10001.599936002624, 10313.639022634172, 10345.84481232767, 10363.0, 10461.529231184615, 13902.51341203053, 13958.720825583432, 13996.72006559863, 14118.647033824236, 14134.78797818013, 7748.922510774933, 8057.556834374049, 8142.959285203536, 8168.197437057734, 8168.346532277404, 7903.328217101611, 7968.087658961807, 8011.919880801117, 8210.343172546181, 8229.547374894319, 4333.58830911063, 4401.735895846259, 4415.933760993587, 4463.174312752087, 4509.210888094571, 1815.3374018483423, 1821.2805941652973, 1844.5204246895635, 1852.6109517001312, 1897.098878032951, 922.7416323429451, 942.7030485397078, 961.4375590279765, 963.1764841060932, 992.6873034993954, 18588.44234672962, 19482.707759383622, 19657.7393599735, 19788.802111978985, 19880.801191988183, 965.8261512927741, 971.9454391984634, 991.5141580625442, 998.9750256243507, 1010.525053224983, 10638.574457021632, 10648.680539583826, 10877.0754485868, 10912.781744365227, 11004.834927476095, 486887.0, 499641.0, 504005.0, 504168.0, 506192.0, 59831.0, 90434.54782726044, 92257.53871230735, 92932.0, 94766.0, 920.889493260813, 936.6159874451442, 956.2350119904049, 962.8892677342055, 966.9033096690275, 16518.83481165173, 16719.247633856263, 16773.32906683768, 17161.570960726083, 17469.650606987536, 40491.39262911118, 41920.0, 42358.36462453004, 42383.7880810594, 44171.11657766762, 53097.734511327195, 53187.0, 55246.0, 62482.0, 62679.37320626918, 7290.599017054113, 7637.198094200029, 7692.076950765944, 8081.595920204084, 8470.915290847013, 9676.419414835133, 12393.752124957631, 13146.934265328613, 13403.32983350809, 13889.444422222998, 11353.829692554784, 11866.466009029442, 12301.876981230072, 12394.504219831106, 12444.626661200178, 10114.544845481823, 10170.237232207763, 11964.521419143137, 12099.395030248628, 12491.437885295001, 12030.699232519257, 12461.626151215478, 12559.93720031394, 12598.937005314914, 12634.747305054032, 8473.745787626382, 8525.668412005913, 8604.913950860411, 8609.139086091342, 8776.473411595325, 8862.911370886466, 11860.881391185978, 11910.52357905674, 11940.641780746591, 12000.519979200733], "value": 8927.972179288747, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1477.9113253204805, 1504.082509669102, 1616.2807550639964, 1725.8619310455165, 1745.720684690449, 7661.233876612336, 8326.167383261678, 8353.582320883961, 8837.469751814888, 8999.100089990998, 8411.873821892661, 8609.784755381103, 8611.224989750921, 8654.653813847439, 8664.74005779826, 2245.38251980705, 2261.570301642691, 2279.0655831109248, 2283.851549649276, 2287.611106111965, 2200.6919031335624, 2217.4899773052207, 2237.574860776447, 2242.6411774116145, 2242.921497747579, 2190.9233176838816, 2192.4299682082615, 2200.5928903152967, 2205.4155648753094, 2222.944426389345, 2132.552164045552, 2149.8280137589036, 2152.472644202173, 2159.492519257973, 2167.7181966344274, 2177.1835561664375, 2180.585688719154, 2185.726784151981, 2188.1684959715208, 2188.7045248891354, 8742.388032837704, 8742.519161446118, 8763.430377025474, 8785.7803554911, 8792.164744349277, 4977.651564390494, 5092.28707980883, 5098.158803797369, 5098.796048158069, 5104.438511763703, 2998.280412700958, 3146.386454641346, 3194.0577529628818, 3205.7595680323834, 3253.6258330292085, 1087.2823936202149, 1114.0586204657134, 1123.5056575106926, 1130.8416821644976, 1137.744007598292, 11861.584844530485, 11945.581904633296, 11954.0, 12048.216865903776, 12085.45615447307, 4279.657627389802, 4323.373110898902, 4386.298192289219, 4414.977925110418, 4423.668224883147, 10091.798164036678, 10228.386296822215, 10306.484675766182, 10324.587016519405, 10336.586536538605, 5027.622928280393, 5074.340335756402, 5080.390353157571, 5084.77118529667, 5099.209622508517, 4196.370544418301, 4468.374427580141, 4559.931601025987, 4607.7004994675235, 4612.054528821651, 3747.9063023424087, 3839.1745774658025, 3845.250176215667, 3866.38137897935, 4024.2957482440456, 1212.5028738217466, 1217.8234156047324, 1219.7682440336307, 1224.9510019599115, 1233.8272641830151, 866.3935245328296, 961.7884065505577, 970.5292932927524, 975.4293738163254, 978.6574698855486, 5839.065749480063, 5855.560832937546, 5928.377071892051, 5981.461668449773, 6066.939330606726, 435.25136764764557, 436.90169711815224, 446.44640645599225, 449.18472971557173, 450.6034689473308, 3923.0, 3981.1042515434374, 3989.5412027617194, 4008.0981779100052, 4034.5360283567766, 10485.68542943713, 10634.521446534924, 10673.946630266799, 10719.624813131659, 10801.243912926177, 10424.478776061167, 10469.110125639407, 10478.161747060218, 10657.786844263226, 10674.359538427563, 8061.314788243065, 8088.352931765445, 8092.959535202286, 8133.308668763103, 8193.180681931879, 5799.8550036249435, 5819.388964158872, 5874.295084589877, 5936.525077993837, 5944.1975333331175, 9677.419354838732, 9744.853827192455, 9873.358231714916, 9975.750606234611, 10065.194784417083, 9961.800763984824, 10013.0, 10033.749156271151, 10045.949770251102, 10174.593016279267, 6856.5200435969, 7572.924270757442, 7856.685732570862, 7872.464869350421, 7878.0, 8656.264217541328, 8666.653333866574, 8715.172058654418, 8761.167689069529, 8776.868346974928, 7695.653695583824, 7871.763847084597, 7971.521708697497, 7991.84016319682, 8030.879536806836, 7687.346575541142, 7847.058352997677, 7855.528668279693, 7885.684572617031, 7961.203879612224, 7000.859982800213, 7101.396381307647, 7126.35862772353, 7170.856582868418, 7171.8565628688175, 5188.09208388523, 5221.4778522149, 5286.048511267855, 5300.734963251745, 5339.7063161526485, 5074.67014644047, 5085.440601533903, 5086.7710953007945, 5231.163013917755, 5252.317198764136], "value": 4458.4392169276225, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.33050923569743, 321.9581454410926, 322.31829680226315, 322.9321842413093, 323.9206394433364, 5599.636023658464, 5667.0165442095295, 5670.829875103748, 5724.370319264877, 5756.366799652035, 5596.552275817935, 5631.7184140793, 5649.915251271234, 5676.659400435967, 5684.289463817023, 4133.3386658134705, 4193.329067349225, 4318.330658747899, 4337.240982828008, 4372.169287835317, 4320.969144502094, 4351.8694439166875, 4362.520122786491, 4362.869113926571, 4371.23503386906, 4303.526612072669, 4331.7400955942585, 4341.9782901085455, 4356.0, 4385.758783266919, 4212.726172798773, 4237.9999999999845, 4313.9137217255475, 4316.287812510964, 4357.564243575617, 3783.6783873370796, 3798.8480460781534, 3800.992736924717, 3818.236352729465, 3823.7323387362894, 5424.376196737387, 5441.891162176774, 5480.205370221335, 5562.888742225133, 5573.804916827932, 4796.242160757543, 4902.313676085351, 4914.164592019365, 4929.433115191727, 4961.9751901240625, 5757.88484230313, 5765.798197063083, 5781.8725348557045, 5875.794347197828, 5948.672822994734, 4191.392248124035, 4211.536730959592, 4215.587778094342, 4230.746155230696, 4242.300020496646, 5924.911126333109, 6104.603200791934, 6105.32841387447, 6126.966558621246, 6136.325004249574, 4222.0289333453475, 4251.851185208503, 4254.574542545721, 4262.339337402707, 4269.530351661315, 4267.594578515036, 4273.35899615054, 4294.420253265832, 4298.376735373354, 4331.350297455407, 4791.880202994883, 4893.755312234374, 4946.604271658259, 4948.084604348207, 5004.499550044967, 5826.523727415832, 5839.708014599253, 5888.793892213752, 5902.704864756745, 5931.4958228550195, 1471.9190444525655, 1500.0, 1506.909585424856, 1510.7054124445847, 1519.8176218853807, 935.9251259899191, 959.5729900194347, 974.9567962280433, 979.0, 986.1223511075149, 5748.741306641211, 5776.653400795965, 5781.0, 5787.536997040227, 5798.536117110621, 6033.698315084228, 6045.972184728606, 6053.152558641794, 6057.303410107894, 6107.62578419852, 5540.418256083134, 5659.463892264672, 5688.601797874192, 5691.658500489983, 5718.285214348207, 3188.8883889064236, 3220.679521396263, 3244.545763593099, 3256.534559448258, 3258.169166862435, 6103.969480152571, 6108.725107370179, 6211.409916057967, 6277.654728989949, 6289.40250676185, 6096.481799047131, 6133.0, 6160.767846430642, 6175.912043978011, 6224.408681175281, 5995.15423708786, 6257.217847769029, 6267.965785645409, 6269.279032911274, 6310.968445157745, 5949.910751338647, 5995.940040599538, 6001.879962400815, 6030.819075427744, 6066.878662426815, 5839.591228613956, 5916.467517923407, 5953.618552579003, 5983.970080149571, 5996.730147143477, 6032.341106195831, 6144.804701555256, 6166.81499555014, 6210.844728881814, 6277.309495955533, 4155.501339839238, 4188.392683061, 4211.894702632459, 4220.15596880619, 4222.387753775747, 6081.726322315418, 6095.695215239131, 6098.75604975796, 6099.939000610115, 6110.388961103854, 5621.2411324472305, 5841.1238314253205, 5945.702714864153, 5964.522838173022, 5970.462658360769, 5827.679477628772, 5840.678762668094, 5870.442307980735, 5870.882582348244, 5900.616459930091, 5325.920111198413, 5670.319561652463, 5704.714764261853, 5757.65454072757, 5825.70871456434, 5912.497437717842, 5933.465988060922, 5934.762609495572, 5950.905529124917, 5960.195373624505, 5595.804146854841, 5798.94201057984, 5857.414258574279, 5872.120921305313, 5886.6173698709445], "value": 4462.4516525830495, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [784.6273020315348, 807.5679511461368, 821.9136990615989, 829.4318391901546, 850.391969741635, 14560.708785824278, 15898.602534936632, 15919.92040039801, 15987.440439584618, 15995.600109997256, 14446.277686115705, 14886.776698349533, 14945.701085978273, 14955.252237388115, 15022.0, 796.760971708488, 803.236924921327, 810.3962547901822, 810.7851419373841, 812.8740045292959, 805.4120492040814, 807.8909347238107, 808.6805711743858, 811.0105671081271, 813.0284310249255, 837.5937670229933, 838.9077201507829, 839.3453106576849, 841.0706169682504, 845.5434065604566, 825.145973916996, 830.6469750356135, 832.4214670803793, 833.0919297965187, 837.0123254559617, 606.0848119339785, 608.7443273825004, 610.7099127914249, 613.4969325153376, 614.081947488503, 16057.678846423123, 16063.678726425524, 16082.19589020556, 16109.113998730065, 16113.838861611352, 14659.0, 15258.694826103527, 15610.843891561053, 15907.60230994223, 16017.759733603889, 12642.304673242968, 12769.936150319189, 12879.162854414433, 13087.149335293176, 13260.204387736767, 3953.9011524711823, 3969.0871099646956, 3976.1053762903116, 4011.859584914543, 4147.129102888397, 64022.3597764021, 64298.0, 79219.0, 79705.0, 79994.60002700008, 11430.828537571942, 11491.988377330832, 11699.88300117005, 11731.381095341152, 11849.22980006314, 23458.413539661302, 23528.764712353, 23579.056837726297, 23748.287551373487, 23929.16247931314, 9033.63865445388, 9050.637974480947, 9058.682946096855, 9161.908380916106, 9166.083391660914, 4774.71351718891, 4820.918151765977, 4884.804607815719, 4928.581070608967, 4961.330220420197, 3671.2473942841652, 3807.7524960877454, 3811.77129372233, 3812.4090765931323, 3814.256220037066, 596.4661627843057, 597.3220394851875, 603.0953569645532, 617.6942413505344, 623.82844717703, 714.9026244714443, 750.3209595316248, 753.8341564855723, 758.2758465665277, 772.7836205862368, 10301.433421161759, 10365.274430789772, 10665.9466702666, 10750.838737418944, 11088.833667494993, 635.7425242776683, 695.8330000799873, 729.3253740290317, 738.9778306650809, 752.5672738175571, 4829.9275510867365, 4897.951020489821, 5224.164133738584, 5258.71077090756, 5310.468953104659, 127297.36351318369, 128804.0, 130108.349458254, 130305.34847325702, 130526.0, 108957.0, 109695.45152274187, 112398.0, 112933.43533282445, 113306.0, 54945.23059094942, 54968.72515637396, 56719.0, 89657.55171224102, 89922.55038724764, 10066.245031622804, 10241.231907607109, 10314.742131446474, 10316.43259620728, 10700.571977120828, 47200.29199561941, 49883.25175122449, 52000.73999629977, 52409.73795131, 53198.0, 67810.3218967804, 70995.64502177456, 76520.23479765354, 76931.61534192294, 77909.2209077902, 13385.598432047054, 13442.059055865995, 13524.79712804289, 13546.390412431267, 13846.307684615931, 15377.615559611098, 15664.686706266039, 15674.216289185722, 15679.843201567839, 15991.760123597922, 13499.527516536875, 13574.389152487964, 13708.314584270547, 14254.287285635884, 14409.495667651581, 13966.301684915918, 14320.498782542561, 14390.928045359706, 14418.927905360406, 14596.12423254608, 12994.740105198032, 14157.504487342894, 14503.637409064435, 14553.85446145525, 14973.32620032123, 11422.371769552423, 11794.76410471803, 11889.702757431134, 11914.106442017057, 12548.749025019632, 12087.637370878887, 12139.311433165969, 12436.19164754288, 12500.187487813264, 12683.80974285368], "value": 7819.3396131357695, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1535.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 110.0, 106.0, 111.0, 116.0, 112.0, 111.0, 109.0, 112.0, 112.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 126.0, 155.0, 178.0, 128.0, 159.0, 153.0, 137.0, 185.0, 126.0], "value": 150.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 163.0, 165.0, 173.0, 165.0, 162.0, 162.0, 160.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 74.0, 162.0, 77.0, 76.0, 75.0, 74.0, 167.0, 84.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 149.0, 85.0, 85.0, 87.0, 146.0, 86.0, 86.0, 137.0], "value": 103.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 116.0, 119.0, 117.0, 117.0, 118.0, 119.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 146.0, 147.0, 147.0, 146.0, 146.0, 149.0, 150.0, 149.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 98.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 58.0, 53.0, 55.0, 55.0, 54.0, 54.0, 55.0, 54.0, 55.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 61.0, 61.0, 62.0, 61.0, 60.0, 61.0, 65.0, 62.0, 62.0], "value": 61.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 82.0, 85.0, 80.0, 80.0, 81.0, 84.0, 99.0, 81.0], "value": 82.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 132.0, 133.0, 129.0, 121.0, 125.0, 122.0, 138.0, 134.0, 124.0], "value": 129.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 158.0, 162.0, 159.0, 158.0, 157.0, 163.0, 160.0, 166.0, 158.0], "value": 159.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 70.0, 65.0, 62.0, 61.0, 63.0, 61.0, 68.0], "value": 63.6, "unit": "score"}]}]} 17:28:40 INFO - Return code: 0 17:28:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:28:40 ERROR - # TBPL SUCCESS # 17:28:40 INFO - Running post-action listener: _resource_record_post_action 17:28:40 INFO - ##### 17:28:40 INFO - ##### Finished run-tests step (success) 17:28:40 INFO - ##### 17:28:40 INFO - Running post-run listener: _resource_record_post_run 17:28:40 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 552185856; Read time: 12; Write time: 524852 17:28:40 INFO - TinderboxPrint: CPU usage
13.4% 17:28:40 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 17:28:40 INFO - TinderboxPrint: I/O write bytes / time
552,185,856 / 524,852 17:28:40 INFO - TinderboxPrint: CPU idle
8,227.9 (86.5%) 17:28:40 INFO - TinderboxPrint: CPU user
1,223.5 (12.9%) 17:28:40 INFO - TinderboxPrint: Swap in / out
0 / 0 17:28:40 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 256643072; Read time: 0; Write time: 305180 17:28:40 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 295542784; Read time: 12; Write time: 219672 17:28:41 INFO - Running post-run listener: _upload_blobber_files 17:28:41 INFO - Blob upload gear active. 17:28:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:28:41 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 17:28:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:28:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:28:41 INFO - (blobuploader) - INFO - Open directory for files ... 17:28:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:28:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:28:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:28:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:28:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:28:42 INFO - (blobuploader) - INFO - Done attempting. 17:28:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:28:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:28:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:28:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:28:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:28:45 INFO - (blobuploader) - INFO - Done attempting. 17:28:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:28:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:28:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:28:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:28:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:28:46 INFO - (blobuploader) - INFO - Done attempting. 17:28:46 INFO - (blobuploader) - INFO - Iteration through files over. 17:28:46 INFO - Return code: 0 17:28:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:28:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:28:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/417b7c013f4fbe03408c69bfaa12f3947b47ddddc7fe3ebb1f885b28082d8afb058349c0736313bc1caa35029a4cb1d1a5f65e77255aab9627509b1dc368508a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2529069f16fb46943fa89c5609e0aa490a5f284d7cc5bae46bb62984f0533793d184407adf95861390b3921eb2d3b4f479ad771d9b3b16014fa582909a7aa0e9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fdd84150821cd50191847e2a033e13c88590f46253f225ef456e78f12ac9582e0385ec6701e1cc2b5a8c2ae2c76c98f21009df7249be3556e7bee86be6a461e3"} 17:28:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:28:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:28:46 INFO - Contents: 17:28:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/417b7c013f4fbe03408c69bfaa12f3947b47ddddc7fe3ebb1f885b28082d8afb058349c0736313bc1caa35029a4cb1d1a5f65e77255aab9627509b1dc368508a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2529069f16fb46943fa89c5609e0aa490a5f284d7cc5bae46bb62984f0533793d184407adf95861390b3921eb2d3b4f479ad771d9b3b16014fa582909a7aa0e9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fdd84150821cd50191847e2a033e13c88590f46253f225ef456e78f12ac9582e0385ec6701e1cc2b5a8c2ae2c76c98f21009df7249be3556e7bee86be6a461e3"} 17:28:46 INFO - Running post-run listener: copy_logs_to_upload_dir 17:28:46 INFO - Copying logs to upload dir... 17:28:46 INFO - mkdir: /builds/slave/test/build/upload/logs 17:28:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.344024 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-27 17:28:46.271779) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 17:28:46.274977) ========= 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=a0d2d2de893abaa8702a9954000001a7-1467071948.857008-1409102459 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/417b7c013f4fbe03408c69bfaa12f3947b47ddddc7fe3ebb1f885b28082d8afb058349c0736313bc1caa35029a4cb1d1a5f65e77255aab9627509b1dc368508a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2529069f16fb46943fa89c5609e0aa490a5f284d7cc5bae46bb62984f0533793d184407adf95861390b3921eb2d3b4f479ad771d9b3b16014fa582909a7aa0e9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fdd84150821cd50191847e2a033e13c88590f46253f225ef456e78f12ac9582e0385ec6701e1cc2b5a8c2ae2c76c98f21009df7249be3556e7bee86be6a461e3"} build_url:https://queue.taskcluster.net/v1/task/N0p-jvidTqKPz4Ar4B817w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011359 build_url: 'https://queue.taskcluster.net/v1/task/N0p-jvidTqKPz4Ar4B817w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/417b7c013f4fbe03408c69bfaa12f3947b47ddddc7fe3ebb1f885b28082d8afb058349c0736313bc1caa35029a4cb1d1a5f65e77255aab9627509b1dc368508a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2529069f16fb46943fa89c5609e0aa490a5f284d7cc5bae46bb62984f0533793d184407adf95861390b3921eb2d3b4f479ad771d9b3b16014fa582909a7aa0e9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fdd84150821cd50191847e2a033e13c88590f46253f225ef456e78f12ac9582e0385ec6701e1cc2b5a8c2ae2c76c98f21009df7249be3556e7bee86be6a461e3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 17:28:46.300659) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 17:28:46.301013) ========= 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=a0d2d2de893abaa8702a9954000001a7-1467071948.857008-1409102459 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004414 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 17:28:46.386530) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 17:28:46.386847) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 17:28:46.387146) ========= ========= Total master_lag: 0.18 =========