builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-017 starttime: 1466198245.72 results: success (0) buildid: 20160617113028 builduid: 2ebf505eaab744e5a26b598fb7969773 revision: 530e96008b7e987c75ddbab59cabdc11f9bbabb9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-17 14:17:25.721695) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-17 14:17:25.722174) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-17 14:17:25.722464) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-17 14:17:25.763294) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 14:17:25.763694) ========= 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=0333a256a5e4f052382dd180000001b1-1466196144.947426-438012893 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-17 14:17:26-- 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% 44.1M=0s 2016-06-17 14:17:26 (44.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.127571 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 14:17:25.909157) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 14:17:25.909491) ========= 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=0333a256a5e4f052382dd180000001b1-1466196144.947426-438012893 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017071 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 14:17:25.960542) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 14:17:25.960914) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 530e96008b7e987c75ddbab59cabdc11f9bbabb9 --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 530e96008b7e987c75ddbab59cabdc11f9bbabb9 --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=0333a256a5e4f052382dd180000001b1-1466196144.947426-438012893 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-17 14:17:26,410 truncating revision to first 12 chars 2016-06-17 14:17:26,410 Setting DEBUG logging. 2016-06-17 14:17:26,410 attempt 1/10 2016-06-17 14:17:26,410 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/530e96008b7e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-17 14:17:26,729 unpacking tar archive at: fx-team-530e96008b7e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.662100 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 14:17:26.641828) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-17 14:17:26.642139) ========= script_repo_revision: 530e96008b7e987c75ddbab59cabdc11f9bbabb9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-17 14:17:26.642545) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-17 14:17:26.642898) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-17 14:17:26.664407) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-06-17 14:17:26.664696) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=0333a256a5e4f052382dd180000001b1-1466196144.947426-438012893 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:17:27 INFO - MultiFileLogger online at 20160617 14:17:27 in /builds/slave/test 14:17:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:17:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:17:27 INFO - {'append_to_log': False, 14:17:27 INFO - 'base_work_dir': '/builds/slave/test', 14:17:27 INFO - 'blob_upload_branch': 'Fx-Team', 14:17:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:17:27 INFO - 'branch': 'Fx-Team', 14:17:27 INFO - 'buildbot_json_path': 'buildprops.json', 14:17:27 INFO - 'config_files': ('talos/linux_config.py',), 14:17:27 INFO - 'default_actions': ('clobber', 14:17:27 INFO - 'read-buildbot-config', 14:17:27 INFO - 'download-and-extract', 14:17:27 INFO - 'populate-webroot', 14:17:27 INFO - 'create-virtualenv', 14:17:27 INFO - 'install', 14:17:27 INFO - 'run-tests'), 14:17:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:17:27 INFO - 'download_minidump_stackwalk': True, 14:17:27 INFO - 'download_symbols': 'ondemand', 14:17:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:17:27 INFO - 'tooltool.py': '/tools/tooltool.py', 14:17:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:17:27 INFO - '/tools/misc-python/virtualenv.py')}, 14:17:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:17:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:17:27 INFO - 'installer_path': 'installer.exe', 14:17:27 INFO - 'log_level': 'info', 14:17:27 INFO - 'log_name': 'talos', 14:17:27 INFO - 'log_to_console': True, 14:17:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:17:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:17:27 INFO - 'opt_config_files': (), 14:17:27 INFO - 'pip_index': False, 14:17:27 INFO - 'sps_profile': False, 14:17:27 INFO - 'sps_profile_interval': 0, 14:17:27 INFO - 'suite': 'dromaeojs', 14:17:27 INFO - 'system_bits': '32', 14:17:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:17:27 INFO - 'title': 'talos-linux64-ix-017', 14:17:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:17:27 INFO - 'use_talos_json': True, 14:17:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:17:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:17:27 INFO - 'work_dir': 'build'} 14:17:27 INFO - ##### 14:17:27 INFO - ##### Running clobber step. 14:17:27 INFO - ##### 14:17:27 INFO - Running pre-action listener: _resource_record_pre_action 14:17:27 INFO - Running main action method: clobber 14:17:27 INFO - rmtree: /builds/slave/test/build 14:17:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:17:27 INFO - Running post-action listener: _resource_record_post_action 14:17:27 INFO - ##### 14:17:27 INFO - ##### Finished clobber step (success) 14:17:27 INFO - ##### 14:17:27 INFO - ##### 14:17:27 INFO - ##### Running read-buildbot-config step. 14:17:27 INFO - ##### 14:17:27 INFO - Running pre-action listener: _resource_record_pre_action 14:17:27 INFO - Running main action method: read_buildbot_config 14:17:27 INFO - Using buildbot properties: 14:17:27 INFO - { 14:17:27 INFO - "project": "", 14:17:27 INFO - "product": "firefox", 14:17:27 INFO - "script_repo_revision": "production", 14:17:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:17:27 INFO - "repository": "", 14:17:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 14:17:27 INFO - "buildid": "20160617113028", 14:17:27 INFO - "pgo_build": "True", 14:17:27 INFO - "basedir": "/builds/slave/test", 14:17:27 INFO - "buildnumber": 197, 14:17:27 INFO - "slavename": "talos-linux64-ix-017", 14:17:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:17:27 INFO - "platform": "ubuntu64_hw", 14:17:27 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:17:27 INFO - "branch": "fx-team", 14:17:27 INFO - "repo_path": "integration/fx-team", 14:17:27 INFO - "revision": "530e96008b7e987c75ddbab59cabdc11f9bbabb9", 14:17:27 INFO - "stage_platform": "linux64-pgo", 14:17:27 INFO - "builduid": "2ebf505eaab744e5a26b598fb7969773", 14:17:27 INFO - "slavebuilddir": "test" 14:17:27 INFO - } 14:17:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 14:17:27 INFO - Running post-action listener: _resource_record_post_action 14:17:27 INFO - ##### 14:17:27 INFO - ##### Finished read-buildbot-config step (success) 14:17:27 INFO - ##### 14:17:27 INFO - ##### 14:17:27 INFO - ##### Running download-and-extract step. 14:17:27 INFO - ##### 14:17:27 INFO - Running pre-action listener: _resource_record_pre_action 14:17:27 INFO - Running main action method: download_and_extract 14:17:27 INFO - mkdir: /builds/slave/test/build/tests 14:17:27 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')]} 14:17:27 INFO - https://queue.taskcluster.net/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:17:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:17:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:17:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/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 14:17:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/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 14:17:39 INFO - Downloaded 1361 bytes. 14:17:39 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:17:39 INFO - Using the following test package requirements: 14:17:39 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:17:39 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:17:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:17:39 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:17:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:17:39 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:17:39 INFO - u'jsshell-linux-x86_64.zip'], 14:17:39 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:17:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:17:39 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:17:39 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:17:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:17:39 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:17:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:17:39 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:17:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:17:39 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:17:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:17:39 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:17:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:39 INFO - https://queue.taskcluster.net/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:17:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:17:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:17:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/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 14:17:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/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 14:17:44 INFO - Downloaded 24221020 bytes. 14:17:44 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'] 14:17:44 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 14:17:46 INFO - Return code: 0 14:17:46 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 14:17:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:46 INFO - https://queue.taskcluster.net/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:17:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:17:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:17:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/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 14:17:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/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 14:17:51 INFO - Downloaded 24221020 bytes. 14:17:51 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'] 14:17:51 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 14:17:53 INFO - Return code: 0 14:17:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:53 INFO - https://queue.taskcluster.net/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:17:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:17:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:17:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/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 14:17:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/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 14:17:54 INFO - Downloaded 14405384 bytes. 14:17:54 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'] 14:17:54 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 14:17:54 INFO - Return code: 0 14:17:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:54 INFO - https://queue.taskcluster.net/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:17:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:17:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:17:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/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 14:17:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/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 14:17:56 INFO - Downloaded 59382147 bytes. 14:17:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:17:56 INFO - mkdir: /builds/slave/test/properties 14:17:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:17:56 INFO - Writing to file /builds/slave/test/properties/build_url 14:17:56 INFO - Contents: 14:17:56 INFO - build_url:https://queue.taskcluster.net/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:17:57 INFO - Running post-action listener: _resource_record_post_action 14:17:57 INFO - Running post-action listener: set_extra_try_arguments 14:17:57 INFO - ##### 14:17:57 INFO - ##### Finished download-and-extract step (success) 14:17:57 INFO - ##### 14:17:57 INFO - ##### 14:17:57 INFO - ##### Running populate-webroot step. 14:17:57 INFO - ##### 14:17:57 INFO - Running pre-action listener: _resource_record_pre_action 14:17:57 INFO - Running main action method: populate_webroot 14:17:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:17:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:17:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:17:57 INFO - '--tppagecycles', 14:17:57 INFO - '7'], 14:17:57 INFO - 'tests': ['tsvgm']}}, 14:17:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:17:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:17:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:17:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:17:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:17:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:17:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:57 INFO - 'talos_options': ['--disable-e10s'], 14:17:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:17:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:17:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:57 INFO - 'talos_options': ['--disable-e10s'], 14:17:57 INFO - 'tests': ['damp', 'tps']}, 14:17:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:57 INFO - 'tests': ['damp', 'tps']}, 14:17:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:17:57 INFO - 'tests': ['dromaeo_dom']}, 14:17:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:17:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:17:57 INFO - 'tests': ['basic_compositor_video']}, 14:17:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:17:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:17:57 INFO - 'tests': ['a11yr', 14:17:57 INFO - 'ts_paint', 14:17:57 INFO - 'tpaint', 14:17:57 INFO - 'sessionrestore', 14:17:57 INFO - 'sessionrestore_no_auto_restore', 14:17:57 INFO - 'tabpaint']}, 14:17:57 INFO - 'other-e10s': {'tests': ['a11yr', 14:17:57 INFO - 'ts_paint', 14:17:57 INFO - 'tpaint', 14:17:57 INFO - 'sessionrestore', 14:17:57 INFO - 'sessionrestore_no_auto_restore', 14:17:57 INFO - 'tabpaint']}, 14:17:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:17:57 INFO - 'ts_paint', 14:17:57 INFO - 'tpaint', 14:17:57 INFO - 'sessionrestore', 14:17:57 INFO - 'sessionrestore_no_auto_restore', 14:17:57 INFO - 'tabpaint']}, 14:17:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:17:57 INFO - 'ts_paint', 14:17:57 INFO - 'tpaint', 14:17:57 INFO - 'sessionrestore', 14:17:57 INFO - 'sessionrestore_no_auto_restore', 14:17:57 INFO - 'tabpaint']}, 14:17:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:17:57 INFO - 'tests': ['a11yr', 14:17:57 INFO - 'ts_paint', 14:17:57 INFO - 'tpaint', 14:17:57 INFO - 'sessionrestore', 14:17:57 INFO - 'sessionrestore_no_auto_restore', 14:17:57 INFO - 'tabpaint']}, 14:17:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:17:57 INFO - 'tests': ['a11yr', 14:17:57 INFO - 'ts_paint', 14:17:57 INFO - 'tpaint', 14:17:57 INFO - 'sessionrestore', 14:17:57 INFO - 'sessionrestore_no_auto_restore', 14:17:57 INFO - 'tabpaint']}, 14:17:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:17:57 INFO - 'tests': ['tsvgx', 14:17:57 INFO - 'tsvgr_opacity', 14:17:57 INFO - 'tart', 14:17:57 INFO - 'tscrollx', 14:17:57 INFO - 'cart']}, 14:17:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:17:57 INFO - 'tsvgr_opacity', 14:17:57 INFO - 'tart', 14:17:57 INFO - 'tscrollx', 14:17:57 INFO - 'cart']}, 14:17:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:57 INFO - 'talos_options': ['--disable-e10s'], 14:17:57 INFO - 'tests': ['tp5o']}, 14:17:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:57 INFO - 'tests': ['tp5o']}, 14:17:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:57 INFO - 'talos_options': ['--disable-e10s', 14:17:57 INFO - '--xperf_path', 14:17:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:17:57 INFO - 'tests': ['tp5n']}, 14:17:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:57 INFO - 'talos_options': ['--xperf_path', 14:17:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:17:57 INFO - 'tests': ['tp5n']}}, 14:17:57 INFO - 'talos.zip': {'path': '', 14:17:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:17:57 INFO - Running post-action listener: _resource_record_post_action 14:17:57 INFO - ##### 14:17:57 INFO - ##### Finished populate-webroot step (success) 14:17:57 INFO - ##### 14:17:57 INFO - ##### 14:17:57 INFO - ##### Running create-virtualenv step. 14:17:57 INFO - ##### 14:17:57 INFO - Running pre-action listener: _resource_record_pre_action 14:17:57 INFO - Running main action method: create_virtualenv 14:17:57 INFO - Creating virtualenv /builds/slave/test/build/venv 14:17:57 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 14:17:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:17:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:17:57 INFO - Using real prefix '/usr' 14:17:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:17:57 INFO - Installing distribute.............................................................................................................................................................................................done. 14:17:59 INFO - Installing pip.................done. 14:17:59 INFO - Return code: 0 14:17:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:17:59 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')]} 14:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:59 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')]} 14:17:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:59 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 0x7fd6bd718f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1887190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1919110>, '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 0x1885230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18856c0>, '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': '0333a256a5e4f052382dd180000001b1-1466196144.947426-438012893', '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 14:17:59 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 14:17:59 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 14:17:59 INFO - Using env: {'DISPLAY': ':0', 14:17:59 INFO - 'HOME': '/home/cltbld', 14:17:59 INFO - 'LANG': 'en_US.UTF-8', 14:17:59 INFO - 'LANGUAGE': 'en_US:en', 14:17:59 INFO - 'LOGNAME': 'cltbld', 14:17:59 INFO - 'MAIL': '/var/mail/cltbld', 14:17:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:59 INFO - 'MOZ_NO_REMOTE': '1', 14:17:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:59 INFO - 'NO_EM_RESTART': '1', 14:17:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:17:59 INFO - 'PWD': '/builds/slave/test', 14:17:59 INFO - 'SHELL': '/bin/bash', 14:17:59 INFO - 'SHLVL': '1', 14:17:59 INFO - 'TERM': 'linux', 14:17:59 INFO - 'TMOUT': '86400', 14:17:59 INFO - 'USER': 'cltbld', 14:17:59 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466196144.947426-438012893', 14:17:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:59 INFO - '_': '/tools/buildbot/bin/python'} 14:18:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:00 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 14:18:00 INFO - Cleaning up... 14:18:00 INFO - Return code: 0 14:18:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:18:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd6bd718f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1887190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1919110>, '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 0x1885230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18856c0>, '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': '0333a256a5e4f052382dd180000001b1-1466196144.947426-438012893', '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 14:18:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:18:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:18:00 INFO - Using env: {'DISPLAY': ':0', 14:18:00 INFO - 'HOME': '/home/cltbld', 14:18:00 INFO - 'LANG': 'en_US.UTF-8', 14:18:00 INFO - 'LANGUAGE': 'en_US:en', 14:18:00 INFO - 'LOGNAME': 'cltbld', 14:18:00 INFO - 'MAIL': '/var/mail/cltbld', 14:18:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:00 INFO - 'MOZ_NO_REMOTE': '1', 14:18:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:00 INFO - 'NO_EM_RESTART': '1', 14:18:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:00 INFO - 'PWD': '/builds/slave/test', 14:18:00 INFO - 'SHELL': '/bin/bash', 14:18:00 INFO - 'SHLVL': '1', 14:18:00 INFO - 'TERM': 'linux', 14:18:00 INFO - 'TMOUT': '86400', 14:18:00 INFO - 'USER': 'cltbld', 14:18:00 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466196144.947426-438012893', 14:18:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:00 INFO - '_': '/tools/buildbot/bin/python'} 14:18:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:00 INFO - Downloading/unpacking psutil>=3.1.1 14:18:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:18:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:18:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:18:02 INFO - Installing collected packages: psutil 14:18:02 INFO - Running setup.py install for psutil 14:18:02 INFO - building 'psutil._psutil_linux' extension 14:18:02 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 14:18:02 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 14:18:02 INFO - building 'psutil._psutil_posix' extension 14:18:02 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 14:18:02 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 14:18:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:18:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:18:02 INFO - Successfully installed psutil 14:18:02 INFO - Cleaning up... 14:18:02 INFO - Return code: 0 14:18:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:18:02 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')]} 14:18:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:02 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')]} 14:18:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:02 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 0x7fd6bd718f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1887190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1919110>, '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 0x1885230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18856c0>, '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': '0333a256a5e4f052382dd180000001b1-1466196144.947426-438012893', '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 14:18:02 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 14:18:02 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 14:18:02 INFO - Using env: {'DISPLAY': ':0', 14:18:02 INFO - 'HOME': '/home/cltbld', 14:18:02 INFO - 'LANG': 'en_US.UTF-8', 14:18:02 INFO - 'LANGUAGE': 'en_US:en', 14:18:02 INFO - 'LOGNAME': 'cltbld', 14:18:02 INFO - 'MAIL': '/var/mail/cltbld', 14:18:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:02 INFO - 'MOZ_NO_REMOTE': '1', 14:18:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:02 INFO - 'NO_EM_RESTART': '1', 14:18:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:02 INFO - 'PWD': '/builds/slave/test', 14:18:02 INFO - 'SHELL': '/bin/bash', 14:18:02 INFO - 'SHLVL': '1', 14:18:02 INFO - 'TERM': 'linux', 14:18:02 INFO - 'TMOUT': '86400', 14:18:02 INFO - 'USER': 'cltbld', 14:18:02 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466196144.947426-438012893', 14:18:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:02 INFO - '_': '/tools/buildbot/bin/python'} 14:18:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:18:03 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 14:18:03 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 14:18:03 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 14:18:03 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 14:18:03 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 14:18:03 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 14:18:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:18:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:18:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:18:05 INFO - Installing collected packages: mozsystemmonitor 14:18:05 INFO - Running setup.py install for mozsystemmonitor 14:18:05 INFO - Successfully installed mozsystemmonitor 14:18:05 INFO - Cleaning up... 14:18:05 INFO - Return code: 0 14:18:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:18: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')]} 14:18:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18: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')]} 14:18:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:05 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 0x7fd6bd718f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1887190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1919110>, '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 0x1885230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18856c0>, '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': '0333a256a5e4f052382dd180000001b1-1466196144.947426-438012893', '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 14:18:05 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 14:18:05 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 14:18:05 INFO - Using env: {'DISPLAY': ':0', 14:18:05 INFO - 'HOME': '/home/cltbld', 14:18:05 INFO - 'LANG': 'en_US.UTF-8', 14:18:05 INFO - 'LANGUAGE': 'en_US:en', 14:18:05 INFO - 'LOGNAME': 'cltbld', 14:18:05 INFO - 'MAIL': '/var/mail/cltbld', 14:18:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:05 INFO - 'MOZ_NO_REMOTE': '1', 14:18:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:05 INFO - 'NO_EM_RESTART': '1', 14:18:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:05 INFO - 'PWD': '/builds/slave/test', 14:18:05 INFO - 'SHELL': '/bin/bash', 14:18:05 INFO - 'SHLVL': '1', 14:18:05 INFO - 'TERM': 'linux', 14:18:05 INFO - 'TMOUT': '86400', 14:18:05 INFO - 'USER': 'cltbld', 14:18:05 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466196144.947426-438012893', 14:18:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:05 INFO - '_': '/tools/buildbot/bin/python'} 14:18:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:05 INFO - Downloading/unpacking jsonschema==2.5.1 14:18:05 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 14:18:05 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 14:18:05 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 14:18:05 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 14:18:05 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 14:18:05 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 14:18:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:18:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:18:07 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 14:18:07 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 14:18:07 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 14:18:07 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 14:18:07 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 14:18:07 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 14:18:07 INFO - Downloading functools32-3.2.3-2.tar.gz 14:18:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:18:07 INFO - warning: no files found matching '*.txt' 14:18:07 INFO - no previously-included directories found matching 'build' 14:18:07 INFO - no previously-included directories found matching 'dist' 14:18:07 INFO - no previously-included directories found matching '.git*' 14:18:07 INFO - Installing collected packages: jsonschema, functools32 14:18:07 INFO - Running setup.py install for functools32 14:18:07 INFO - warning: no files found matching '*.txt' 14:18:07 INFO - no previously-included directories found matching 'build' 14:18:07 INFO - no previously-included directories found matching 'dist' 14:18:07 INFO - no previously-included directories found matching '.git*' 14:18:07 INFO - Successfully installed jsonschema functools32 14:18:07 INFO - Cleaning up... 14:18:07 INFO - Return code: 0 14:18:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:18:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:07 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 0x7fd6bd718f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1887190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1919110>, '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 0x1885230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18856c0>, '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': '0333a256a5e4f052382dd180000001b1-1466196144.947426-438012893', '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 14:18:07 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 14:18:07 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 14:18:07 INFO - Using env: {'DISPLAY': ':0', 14:18:07 INFO - 'HOME': '/home/cltbld', 14:18:07 INFO - 'LANG': 'en_US.UTF-8', 14:18:07 INFO - 'LANGUAGE': 'en_US:en', 14:18:07 INFO - 'LOGNAME': 'cltbld', 14:18:07 INFO - 'MAIL': '/var/mail/cltbld', 14:18:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:07 INFO - 'MOZ_NO_REMOTE': '1', 14:18:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:07 INFO - 'NO_EM_RESTART': '1', 14:18:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:07 INFO - 'PWD': '/builds/slave/test', 14:18:07 INFO - 'SHELL': '/bin/bash', 14:18:07 INFO - 'SHLVL': '1', 14:18:07 INFO - 'TERM': 'linux', 14:18:07 INFO - 'TMOUT': '86400', 14:18:07 INFO - 'USER': 'cltbld', 14:18:07 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466196144.947426-438012893', 14:18:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:07 INFO - '_': '/tools/buildbot/bin/python'} 14:18:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:07 INFO - Downloading/unpacking blobuploader==1.2.4 14:18:07 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 14:18:07 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 14:18:07 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 14:18:07 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 14:18:07 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 14:18:07 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 14:18:09 INFO - Downloading blobuploader-1.2.4.tar.gz 14:18:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:18:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:18:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:18:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:18:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:10 INFO - Downloading docopt-0.6.1.tar.gz 14:18:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:18:10 INFO - Installing collected packages: blobuploader, requests, docopt 14:18:10 INFO - Running setup.py install for blobuploader 14:18:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:18:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:18:10 INFO - Running setup.py install for requests 14:18:11 INFO - Running setup.py install for docopt 14:18:11 INFO - Successfully installed blobuploader requests docopt 14:18:11 INFO - Cleaning up... 14:18:11 INFO - Return code: 0 14:18:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:18:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:11 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 0x7fd6bd718f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1887190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1919110>, '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 0x1885230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18856c0>, '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': '0333a256a5e4f052382dd180000001b1-1466196144.947426-438012893', '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 14:18:11 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 14:18:11 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 14:18:11 INFO - Using env: {'DISPLAY': ':0', 14:18:11 INFO - 'HOME': '/home/cltbld', 14:18:11 INFO - 'LANG': 'en_US.UTF-8', 14:18:11 INFO - 'LANGUAGE': 'en_US:en', 14:18:11 INFO - 'LOGNAME': 'cltbld', 14:18:11 INFO - 'MAIL': '/var/mail/cltbld', 14:18:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:11 INFO - 'MOZ_NO_REMOTE': '1', 14:18:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:11 INFO - 'NO_EM_RESTART': '1', 14:18:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:11 INFO - 'PWD': '/builds/slave/test', 14:18:11 INFO - 'SHELL': '/bin/bash', 14:18:11 INFO - 'SHLVL': '1', 14:18:11 INFO - 'TERM': 'linux', 14:18:11 INFO - 'TMOUT': '86400', 14:18:11 INFO - 'USER': 'cltbld', 14:18:11 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466196144.947426-438012893', 14:18:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:11 INFO - '_': '/tools/buildbot/bin/python'} 14:18:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:18:11 INFO - Running setup.py (path:/tmp/pip-FfX7JP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:18:11 INFO - Running setup.py (path:/tmp/pip-i5PfD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:18:11 INFO - Running setup.py (path:/tmp/pip-5DjJxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:18:11 INFO - Running setup.py (path:/tmp/pip-qFpTL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:18:11 INFO - Running setup.py (path:/tmp/pip-KeTPhm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:18:11 INFO - Running setup.py (path:/tmp/pip-Ojw4w_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:18:11 INFO - Running setup.py (path:/tmp/pip-MIohUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:18:11 INFO - Running setup.py (path:/tmp/pip-K8M7yT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:18:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:18:11 INFO - Running setup.py (path:/tmp/pip-3OPGUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:18:12 INFO - Running setup.py (path:/tmp/pip-Lxl5na-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:18:12 INFO - Running setup.py (path:/tmp/pip-kq6FQy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:18:12 INFO - Running setup.py (path:/tmp/pip-BNiFbw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:18:12 INFO - Running setup.py (path:/tmp/pip-4HYi2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:18:12 INFO - Running setup.py (path:/tmp/pip-RhgLrl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:18:12 INFO - Running setup.py (path:/tmp/pip-6r2zk5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:18:12 INFO - Running setup.py (path:/tmp/pip-S_asvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:18:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:18:12 INFO - Running setup.py (path:/tmp/pip-5eluws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:18:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:18:12 INFO - Running setup.py install for manifestparser 14:18:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:18:12 INFO - Running setup.py install for mozcrash 14:18:12 INFO - Running setup.py install for mozdebug 14:18:12 INFO - Running setup.py install for mozdevice 14:18:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:18:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:18:13 INFO - Running setup.py install for mozfile 14:18:13 INFO - Running setup.py install for mozhttpd 14:18:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:18:13 INFO - Running setup.py install for mozinfo 14:18:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:18:13 INFO - Running setup.py install for mozInstall 14:18:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:18:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:18:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:18:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:18:13 INFO - Running setup.py install for mozleak 14:18:13 INFO - Running setup.py install for mozlog 14:18:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:18:13 INFO - Running setup.py install for moznetwork 14:18:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:18:13 INFO - Running setup.py install for mozprocess 14:18:13 INFO - Running setup.py install for mozprofile 14:18:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:18:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:18:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:18:14 INFO - Running setup.py install for mozrunner 14:18:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:18:14 INFO - Running setup.py install for mozscreenshot 14:18:14 INFO - Running setup.py install for moztest 14:18:14 INFO - Running setup.py install for mozversion 14:18:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:18:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:18:14 INFO - Cleaning up... 14:18:14 INFO - Return code: 0 14:18:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:18:14 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')]} 14:18:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:14 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')]} 14:18:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:14 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 0x7fd6bd718f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1887190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1919110>, '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 0x1885230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18856c0>, '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': '0333a256a5e4f052382dd180000001b1-1466196144.947426-438012893', '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 14:18:14 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 14:18:14 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 14:18:14 INFO - Using env: {'DISPLAY': ':0', 14:18:14 INFO - 'HOME': '/home/cltbld', 14:18:14 INFO - 'LANG': 'en_US.UTF-8', 14:18:14 INFO - 'LANGUAGE': 'en_US:en', 14:18:14 INFO - 'LOGNAME': 'cltbld', 14:18:14 INFO - 'MAIL': '/var/mail/cltbld', 14:18:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:14 INFO - 'MOZ_NO_REMOTE': '1', 14:18:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:14 INFO - 'NO_EM_RESTART': '1', 14:18:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:14 INFO - 'PWD': '/builds/slave/test', 14:18:14 INFO - 'SHELL': '/bin/bash', 14:18:14 INFO - 'SHLVL': '1', 14:18:14 INFO - 'TERM': 'linux', 14:18:14 INFO - 'TMOUT': '86400', 14:18:14 INFO - 'USER': 'cltbld', 14:18:14 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466196144.947426-438012893', 14:18:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:14 INFO - '_': '/tools/buildbot/bin/python'} 14:18:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:18:14 INFO - Running setup.py (path:/tmp/pip-Bf0VkJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:18:14 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)) 14:18:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:18:14 INFO - Running setup.py (path:/tmp/pip-fZEDav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:18:14 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)) 14:18:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:18:14 INFO - Running setup.py (path:/tmp/pip-CIEdyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:18:14 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)) 14:18:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:18:14 INFO - Running setup.py (path:/tmp/pip-UbwetS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:18:14 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)) 14:18:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:18:14 INFO - Running setup.py (path:/tmp/pip-eP6Fsb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:18:15 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)) 14:18:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:18:15 INFO - Running setup.py (path:/tmp/pip-EuPI8M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:18:15 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)) 14:18:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:18:15 INFO - Running setup.py (path:/tmp/pip-TT4gTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:18:15 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)) 14:18:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:18:15 INFO - Running setup.py (path:/tmp/pip-VoKUnu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:18:15 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)) 14:18:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:18:15 INFO - Running setup.py (path:/tmp/pip-_BXr6j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:18:15 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)) 14:18:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:18:15 INFO - Running setup.py (path:/tmp/pip-bDlmqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:18:15 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)) 14:18:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:18:15 INFO - Running setup.py (path:/tmp/pip-X_KRPB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:18:15 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)) 14:18:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:18:15 INFO - Running setup.py (path:/tmp/pip-B2HDee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:18:15 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)) 14:18:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:18:15 INFO - Running setup.py (path:/tmp/pip-uecIMc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:18:15 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)) 14:18:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:18:15 INFO - Running setup.py (path:/tmp/pip-42MzgS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:18:15 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)) 14:18:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:18:15 INFO - Running setup.py (path:/tmp/pip-7jLj8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:18:15 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)) 14:18:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:18:15 INFO - Running setup.py (path:/tmp/pip-N57MN4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:18:15 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)) 14:18:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:18:15 INFO - Running setup.py (path:/tmp/pip-cForZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:18:15 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)) 14:18:15 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)) 14:18:15 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)) 14:18:15 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)) 14:18:15 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)) 14:18:15 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)) 14:18:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:18:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:17 INFO - Downloading blessings-1.6.tar.gz 14:18:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:18:17 INFO - Installing collected packages: blessings 14:18:17 INFO - Running setup.py install for blessings 14:18:17 INFO - Successfully installed blessings 14:18:17 INFO - Cleaning up... 14:18:18 INFO - Return code: 0 14:18:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:18:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:18:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:18:18 INFO - Reading from file tmpfile_stdout 14:18:18 INFO - Current package versions: 14:18:18 INFO - argparse == 1.2.1 14:18:18 INFO - blessings == 1.6 14:18:18 INFO - blobuploader == 1.2.4 14:18:18 INFO - docopt == 0.6.1 14:18:18 INFO - functools32 == 3.2.3-2 14:18:18 INFO - jsonschema == 2.5.1 14:18:18 INFO - manifestparser == 1.1 14:18:18 INFO - mozInstall == 1.12 14:18:18 INFO - mozcrash == 0.17 14:18:18 INFO - mozdebug == 0.1 14:18:18 INFO - mozdevice == 0.48 14:18:18 INFO - mozfile == 1.2 14:18:18 INFO - mozhttpd == 0.7 14:18:18 INFO - mozinfo == 0.9 14:18:18 INFO - mozleak == 0.1 14:18:18 INFO - mozlog == 3.2 14:18:18 INFO - moznetwork == 0.27 14:18:18 INFO - mozprocess == 0.22 14:18:18 INFO - mozprofile == 0.28 14:18:18 INFO - mozrunner == 6.11 14:18:18 INFO - mozscreenshot == 0.1 14:18:18 INFO - mozsystemmonitor == 0.3 14:18:18 INFO - moztest == 0.7 14:18:18 INFO - mozversion == 1.4 14:18:18 INFO - psutil == 3.1.1 14:18:18 INFO - requests == 1.2.3 14:18:18 INFO - wsgiref == 0.1.2 14:18:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:18:18 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')]} 14:18:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:18 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')]} 14:18:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:18 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 0x7fd6bd718f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1887190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1919110>, '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 0x1885230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18856c0>, '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': '0333a256a5e4f052382dd180000001b1-1466196144.947426-438012893', '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 14:18:18 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 14:18:18 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 14:18:18 INFO - Using env: {'DISPLAY': ':0', 14:18:18 INFO - 'HOME': '/home/cltbld', 14:18:18 INFO - 'LANG': 'en_US.UTF-8', 14:18:18 INFO - 'LANGUAGE': 'en_US:en', 14:18:18 INFO - 'LOGNAME': 'cltbld', 14:18:18 INFO - 'MAIL': '/var/mail/cltbld', 14:18:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:18 INFO - 'MOZ_NO_REMOTE': '1', 14:18:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:18 INFO - 'NO_EM_RESTART': '1', 14:18:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:18 INFO - 'PWD': '/builds/slave/test', 14:18:18 INFO - 'SHELL': '/bin/bash', 14:18:18 INFO - 'SHLVL': '1', 14:18:18 INFO - 'TERM': 'linux', 14:18:18 INFO - 'TMOUT': '86400', 14:18:18 INFO - 'USER': 'cltbld', 14:18:18 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466196144.947426-438012893', 14:18:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:18 INFO - '_': '/tools/buildbot/bin/python'} 14:18:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:18 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)) 14:18:18 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)) 14:18:18 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)) 14:18:18 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)) 14:18:18 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)) 14:18:18 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)) 14:18:18 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)) 14:18:18 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)) 14:18:18 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)) 14:18:18 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)) 14:18:18 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)) 14:18:18 INFO - Cleaning up... 14:18:18 INFO - Return code: 0 14:18:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:18:18 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')]} 14:18:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:18 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')]} 14:18:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:18 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 0x7fd6bd718f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1887190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1919110>, '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 0x1885230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18856c0>, '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': '0333a256a5e4f052382dd180000001b1-1466196144.947426-438012893', '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 14:18:18 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 14:18:18 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 14:18:18 INFO - Using env: {'DISPLAY': ':0', 14:18:18 INFO - 'HOME': '/home/cltbld', 14:18:18 INFO - 'LANG': 'en_US.UTF-8', 14:18:18 INFO - 'LANGUAGE': 'en_US:en', 14:18:18 INFO - 'LOGNAME': 'cltbld', 14:18:18 INFO - 'MAIL': '/var/mail/cltbld', 14:18:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:18 INFO - 'MOZ_NO_REMOTE': '1', 14:18:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:18 INFO - 'NO_EM_RESTART': '1', 14:18:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:18 INFO - 'PWD': '/builds/slave/test', 14:18:18 INFO - 'SHELL': '/bin/bash', 14:18:18 INFO - 'SHLVL': '1', 14:18:18 INFO - 'TERM': 'linux', 14:18:18 INFO - 'TMOUT': '86400', 14:18:18 INFO - 'USER': 'cltbld', 14:18:18 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466196144.947426-438012893', 14:18:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:18 INFO - '_': '/tools/buildbot/bin/python'} 14:18:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:18:18 INFO - Cleaning up... 14:18:18 INFO - Return code: 0 14:18:18 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:18:18 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')]} 14:18:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:18:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:18 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')]} 14:18:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:18:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:18:18 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 0x7fd6bd718f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17ba8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1887190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1919110>, '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 0x1885230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18856c0>, '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': '0333a256a5e4f052382dd180000001b1-1466196144.947426-438012893', '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 14:18:18 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 14:18:18 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 14:18:18 INFO - Using env: {'DISPLAY': ':0', 14:18:18 INFO - 'HOME': '/home/cltbld', 14:18:18 INFO - 'LANG': 'en_US.UTF-8', 14:18:18 INFO - 'LANGUAGE': 'en_US:en', 14:18:18 INFO - 'LOGNAME': 'cltbld', 14:18:18 INFO - 'MAIL': '/var/mail/cltbld', 14:18:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:18 INFO - 'MOZ_NO_REMOTE': '1', 14:18:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:18 INFO - 'NO_EM_RESTART': '1', 14:18:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:18 INFO - 'PWD': '/builds/slave/test', 14:18:18 INFO - 'SHELL': '/bin/bash', 14:18:18 INFO - 'SHLVL': '1', 14:18:18 INFO - 'TERM': 'linux', 14:18:18 INFO - 'TMOUT': '86400', 14:18:18 INFO - 'USER': 'cltbld', 14:18:18 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466196144.947426-438012893', 14:18:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:18 INFO - '_': '/tools/buildbot/bin/python'} 14:18:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:18:18 INFO - Downloading/unpacking flake8 14:18:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:18:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:18:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:18:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:18:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:18:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:18:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:18:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:18:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:18:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:18:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:18:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:18:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:18:21 INFO - no previously-included directories found matching 'docs/_build' 14:18:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:18:21 INFO - Running setup.py install for pep8 14:18:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:18:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:18:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:18:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:18:21 INFO - no previously-included directories found matching 'docs/_build' 14:18:21 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:18:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:18:21 INFO - Cleaning up... 14:18:21 INFO - Return code: 0 14:18:21 INFO - Running post-action listener: _resource_record_post_action 14:18:21 INFO - Running post-action listener: _start_resource_monitoring 14:18:21 INFO - Starting resource monitoring. 14:18:21 INFO - ##### 14:18:21 INFO - ##### Finished create-virtualenv step (success) 14:18:21 INFO - ##### 14:18:21 INFO - ##### 14:18:21 INFO - ##### Running install step. 14:18:21 INFO - ##### 14:18:21 INFO - Running pre-action listener: _resource_record_pre_action 14:18:21 INFO - Running main action method: install 14:18:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:18:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:18:21 INFO - Reading from file tmpfile_stdout 14:18:21 INFO - Detecting whether we're running mozinstall >=1.0... 14:18:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:18:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:18:22 INFO - Reading from file tmpfile_stdout 14:18:22 INFO - Output received: 14:18:22 INFO - Usage: mozinstall [options] installer 14:18:22 INFO - Options: 14:18:22 INFO - -h, --help show this help message and exit 14:18:22 INFO - -d DEST, --destination=DEST 14:18:22 INFO - Directory to install application into. [default: 14:18:22 INFO - "/builds/slave/test"] 14:18:22 INFO - --app=APP Application being installed. [default: firefox] 14:18:22 INFO - mkdir: /builds/slave/test/build/application 14:18:22 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'] 14:18:22 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 14:18:39 INFO - Reading from file tmpfile_stdout 14:18:39 INFO - Output received: 14:18:39 INFO - /builds/slave/test/build/application/firefox/firefox 14:18:39 INFO - Running post-action listener: _resource_record_post_action 14:18:39 INFO - ##### 14:18:39 INFO - ##### Finished install step (success) 14:18:39 INFO - ##### 14:18:39 INFO - ##### 14:18:39 INFO - ##### Running run-tests step. 14:18:39 INFO - ##### 14:18:39 INFO - Running pre-action listener: _resource_record_pre_action 14:18:39 INFO - Running main action method: run_tests 14:18:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:18:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:18:39 INFO - Python 2.7.3 14:18:39 INFO - Return code: 0 14:18:39 INFO - grabbing minidump binary from tooltool 14:18:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:18:39 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 0x1919110>, '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 0x1885230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18856c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:18:39 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 14:18:39 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 14:18:39 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 14:18:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:18:39 INFO - Return code: 0 14:18:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:18:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:18:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:18:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:18:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:18:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:18:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:18:40 INFO - Return code: 0 14:18:40 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:18:40 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:18:40 INFO - Using env: {'DISPLAY': ':0', 14:18:40 INFO - 'HOME': '/home/cltbld', 14:18:40 INFO - 'LANG': 'en_US.UTF-8', 14:18:40 INFO - 'LANGUAGE': 'en_US:en', 14:18:40 INFO - 'LOGNAME': 'cltbld', 14:18:40 INFO - 'MAIL': '/var/mail/cltbld', 14:18:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:18:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:18:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:40 INFO - 'MOZ_NO_REMOTE': '1', 14:18:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:18:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:18:40 INFO - 'NO_EM_RESTART': '1', 14:18:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:18:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:40 INFO - 'PWD': '/builds/slave/test', 14:18:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:18:40 INFO - 'SHELL': '/bin/bash', 14:18:40 INFO - 'SHLVL': '1', 14:18:40 INFO - 'TERM': 'linux', 14:18:40 INFO - 'TMOUT': '86400', 14:18:40 INFO - 'USER': 'cltbld', 14:18:40 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1466196144.947426-438012893', 14:18:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:40 INFO - '_': '/tools/buildbot/bin/python'} 14:18:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:18:40 INFO - mozversion application_buildid: 20160617113028 14:18:40 INFO - mozversion application_changeset: 530e96008b7e987c75ddbab59cabdc11f9bbabb9 14:18:40 INFO - mozversion application_display_name: Nightly 14:18:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:18:40 INFO - mozversion application_name: Firefox 14:18:40 INFO - mozversion application_remotingname: firefox 14:18:40 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:18:40 INFO - mozversion application_vendor: Mozilla 14:18:40 INFO - mozversion application_version: 50.0a1 14:18:40 INFO - mozversion platform_buildid: 20160617113028 14:18:40 INFO - mozversion platform_changeset: 530e96008b7e987c75ddbab59cabdc11f9bbabb9 14:18:40 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:18:40 INFO - mozversion platform_version: 50.0a1 14:18:40 INFO - using testdate: 1466198320 14:18:40 INFO - actual date: 1466198320 14:18:40 INFO - starting webserver on 'localhost:50864' 14:18:40 INFO - SUITE-START | Running 2 tests 14:18:40 INFO - TEST-START | dromaeo_css 14:18:40 INFO - operating with platform_type : linux_ 14:18:40 INFO - Initialising browser for dromaeo_css test... 14:18:40 INFO - TEST-INFO | started process 5000 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz88Ves/profile http://localhost:50864/getInfo.html) 14:18:44 INFO - PROCESS | 5000 | __metrics Screen width/height:1600/1200 14:18:44 INFO - PROCESS | 5000 | colorDepth:24 14:18:44 INFO - PROCESS | 5000 | Browser inner width/height: 1024/697 14:18:44 INFO - PROCESS | 5000 | __metrics 14:18:45 INFO - PROCESS | 5000 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:18:46 INFO - TEST-INFO | 5000: exit 0 14:18:46 INFO - Browser initialized. 14:18:46 INFO - Running cycle 1/1 for dromaeo_css test... 14:18:46 INFO - TEST-INFO | started process 5086 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz88Ves/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:18:58 INFO - PROCESS | 5086 | RSS: Main: 173559808 14:18:58 INFO - PROCESS | 5086 | 14:19:48 INFO - PROCESS | 5086 | 1466198388746 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] 14:21:57 INFO - PROCESS | 5086 | Cycle 1(1): loaded http://localhost:50864/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50864/tests/dromaeo/cssquery-ext.html) 14:21:58 INFO - PROCESS | 5086 | RSS: Main: 263884800 14:21:58 INFO - PROCESS | 5086 | 14:25:00 INFO - PROCESS | 5086 | Cycle 1(1): loaded http://localhost:50864/tests/dromaeo/cssquery-ext.html (next: http://localhost:50864/tests/dromaeo/cssquery-jquery.html) 14:25:01 INFO - PROCESS | 5086 | RSS: Main: 257429504 14:25:01 INFO - PROCESS | 5086 | 14:28:03 INFO - PROCESS | 5086 | Cycle 1(1): loaded http://localhost:50864/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50864/tests/dromaeo/cssquery-mootools.html) 14:28:03 INFO - PROCESS | 5086 | RSS: Main: 264695808 14:28:03 INFO - PROCESS | 5086 | 14:31:06 INFO - PROCESS | 5086 | Cycle 1(1): loaded http://localhost:50864/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50864/tests/dromaeo/cssquery-prototype.html) 14:31:06 INFO - PROCESS | 5086 | RSS: Main: 257232896 14:31:06 INFO - PROCESS | 5086 | 14:34:09 INFO - PROCESS | 5086 | Cycle 1(1): loaded http://localhost:50864/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50864/tests/dromaeo/cssquery-yui.html) 14:34:09 INFO - PROCESS | 5086 | RSS: Main: 240123904 14:34:09 INFO - PROCESS | 5086 | 14:37:12 INFO - PROCESS | 5086 | Cycle 1(1): loaded http://localhost:50864/tests/dromaeo/cssquery-yui.html (next: http://localhost:50864/tests/dromaeo/cssquery-dojo.html) 14:37:13 INFO - PROCESS | 5086 | RSS: Main: 299098112 14:37:13 INFO - PROCESS | 5086 | 14:37:13 INFO - PROCESS | 5086 | __start_tp_report 14:37:13 INFO - PROCESS | 5086 | _x_x_mozilla_page_load 14:37:13 INFO - PROCESS | 5086 | _x_x_mozilla_page_load_details 14:37:13 INFO - PROCESS | 5086 | |i|pagename|runs| 14:37:13 INFO - PROCESS | 5086 | |0;dojo.html;3090.4128215639025;3104.161876293401;3111.1599868035632;3147.040152753409;3159.6366417861936;5187.714675692835;5223.947760522394;5235.162374020158;5340.145576707728;5357.303550538424;5264.894702105956;5266.236395722618;5325.600579956499;5360.249565060894;5391.16436952272;4810.951890481103;4862.051899879525;4890.951090489085;4896.706197628136;5038.521340472649;4948.851534453972;4975.751212439382;4992.550670439659;5015.498450154973;5035.345405097332;4775.808967641307;4812.205986012304;4849.9757501212625;4855.878603034917;4869.8782530436665;4792.544708252711;4794.568488836021;4798.328234047236;4860.246661767432;4898.387701537308;4806.447258565275;4817.4219093708625;4845.6123510119105;4859.246816743375;4881.8535443936735;5206.323177986876;5228.294180285651;5266.394364648077;5267;5361.785528578852;5633.492985631313;5657.09486482165;5679.971600142014;5695.088785794253;5703.116017017369;5729.684867332295;5738.340090889559;5742.368339482654;5743.597948143632;5745.080787074048;5189.091908915962;5256.6057545684225;5306.336707911511;5308.601854860863;5389.649672771257;5855.882882342329;5866.560007999417;5868.853278668067;5873.089671100986;5874.441928016831;5437.238786569884;5641.238432811518;5647.209390685307;5649.209110724501;5649.745761440745;5599.972000139973;5659.320881494247;5660.575456840754;5689.459501347365;5694.715264236772;5649.661020338793;5656.179853921159;5660.660360378391;5667.659940403507;5669.546436285087;5548.91676624851;5581.413951535112;5662.292213473316;5663.1505274208375;5666.886662266732;4334.5882141196535;4334.631556317749;4338.284183109751;4350;4379.146066516999;3867.5358956925347;3879.437481565157;3892.5523564789846;3900.8010840540455;3919.980400097981;5268.420473747885;5335.0663633863915;5338.492843179892;5365.061114304981;5400.756965936543;5654.095344744904;5661.66030038199;5663.263775709213;5680.943190568124;5724.656520608777;5406.486383793534;5436.972815135899;5449.782008719607;5455.1544510600925;5476.17857321405;4828.179209534387;4868.561829435368;4918.360613120271;4971.055499455092;5009.273655319958;5937.881242375129;5943.791967281211;5948.85127871798;5952.8809423812145;5991;5726.656400615976;5740.827775166752;5741.971290143522;5745.2818397700285;5748;5681.4034526374135;5715.457031581993;5738.483536481736;5797.9420205797405;5919.467247947706;5528.640638358494;5535.972320138373;5543.501084902378;5543.805966791143;5547.694876781816;5591.8881622368135;5610.4670056344585;5625.606207565431;5635.295588051494;5636.915446268227;5432.728363581726;5455.863603409946;5479.643823151482;5507.394186639546;5558.555315574664;5554.555635549227;5559.610827242216;5566.443355664401;5567.4432556744005;5567.7494512747835;5345.839624811262;5429.864253393539;5441.5374693151525;5443.59173062014;5446.155845843742;5464.890702185855;5516.172574113915;5519.144532597454;5590.329160500766;5598.944010560005;5408;5414.891702165856;5415.2689386933835;5422.674639521641;5423.9186412204635 14:37:13 INFO - PROCESS | 5086 | |1;ext.html;596.5645079092262;612.4702132655253;616.4883146988001;633.3666333666333;641.9903701444479;32497.51253731193;35839.82080089599;41432.79283603586;42235.57764422355;42292.788536057276;43359.3496097558;43714.56285437145;43825.56174438255;43840.561594384126;43880.78059609706;8865.290776737846;9017.143371379741;9023.593938272761;9025.052369501174;9028.458292502439;8870.024297327322;8958.596863141174;8976.326775491832;8978.41640293382;8979.910200898006;8995.5052472114;9028.32287578431;9030.322725795559;9030.322725795559;9031.909680903205;8933.55332233389;8947.552622368856;8955.507447090407;8967.506787126673;8981.326400519922;8831;8879.200871921557;8896.199342059246;8900.37697361185;8901.243394311427;41815.327386904486;42263.366049509284;42288.57711422877;42334.1533169338;42350.57649423497;3485.041613556267;3616.439451884962;3733.906652333686;3752.868649597251;3947.6447119759073;32317.6768232317;32473.51289730656;32637.184070398194;32665.51001734976;34195.82902085499;4164.229617520738;4366.170427618742;4386.69119141701;4390.626796722282;4407.259132642588;363565;365011;365249;365539.9999999973;366740;33785.83107084449;57738;57878.421215787304;58000.70999644975;58020.70989645025;34954.300913982086;36759;36760.448593271125;36821;36839;15381.230938453033;15570.610734731723;15579;15601.219939003004;15601.219939003231;13034.348282585834;13125.540606078932;13128.803067953988;13129.803052954214;13146.27695476758;8213.260806527442;8268.462549934235;8272.627731752085;8300.70947516834;8361.95819020901;3156.921076973048;3194.1535493094348;3212.213007813101;3213.5179723041265;3260.4620237660993;994.6767300627325;1021.1575450253571;1026.5021464589668;1098.7308109513222;1105.2539535813455;31954.68045319517;32348.676513235037;32574;32688;33385.332293354;1110.1951085462974;1129.1136457880525;1136.7499150187111;1148.5520646947698;1236.3632729144497;16793.41223057187;17190.484285471455;17201.45186933182;17340.4797856062;17436.422971305736;145819;146036;147475.2626236862;510750;511902;58050.41949580535;58445.99999999915;58951;58989.10108989067;59260.40739592635;1230.0712961713848;1327.5353626230935;1340.1155237543176;1341.5170538606094;1396.71367369691;29583.816647333864;33333.83333083416;33434.66565334315;33712.831435842665;33786.662133378355;51052;51674.74162629163;51762.223566647284;52012.219816702025;52375;411351;424648;426006;426038;427490;37637.2472550542;38756.224875501764;38839.80580097081;42096;42436.575634243265;45182.32226516539;49052.75473622609;49146;50067.49932500628;50181.74909125431;40528.797356013034;41223.381649274685;41854;42580.36129458123;42622;40708;40781.388279176426;41120.588794112875;41642.58357416508;41830.58169418267;39736.59678283132;40768.388474172316;41432.75701728953;41433.37849932193;41552.168956620095;33182.83408582942;36565.26869462649;37244.81377593095;37462;37706;27541.44917101687;27635.44729105447;27823.443531128858;28069.43861122725;28101 14:37:13 INFO - PROCESS | 5086 | |2;jquery.html;379.2869405517627;379.3456287903367;389.67267495303946;397.21549938870714;402.98992525186867;17658.381956631503;19384.806151938476;19747.703784443227;20129.194832206693;20145.899270503665;18440.538986525342;19031.809681903178;19318;19386.51533711658;19410.51473713158;5432.320959880015;5540.36285827129;5681.403452637475;5686.459786320293;5687.374388817227;5526.392096869341;5591.692456914868;5604.551635869121;5624.831255062334;5628.971855140739;5471.863203419906;5519.31008623922;5564;5586.692731899744;5662.773489060432;5506.119020956648;5555.3333599967855;5574.888502229973;5594.636348637326;5599.076152434844;4936.570461455486;5018.64869459138;5064.088464076464;5069.417017043013;5071.391433028023;22488.32535023952;22606.54786904269;22802.771972280232;23158.768412316;23201.53596928052;2979.3743313903888;3001.8048826826184;3033.635963684372;3054.6487153977355;3160.7787454878166;7050.0482434871665;7054.929450705478;7074.045003924456;7078.539894906815;7892.644830982619;1879.8590105742123;1963.3128405058258;2025.8480613954011;2036.8268697160759;2086.613976414353;75018.21263436512;77005.61497192478;77489.61255193745;78665.21334786693;79565.20434795636;10190.133838623651;10224.437655928847;10332.225083118796;10511.737206569896;10670.093042091508;14200;14309.856901430852;14317.498887538886;14340.856591434162;14343.211123388313;8108.959455202804;8126.55303958288;8239.134890836496;8345.290650294794;8430.915690843136;7598.772036838904;7604.619769011527;8176.223258790405;8236.711715090063;8327.541985190872;6279.215098112736;6423.389777971085;6446.774362897276;6488.442773734364;6489.1888513935755;1828.31438210671;1867.8979402152795;1876.5777700017659;1892.649859775946;1903.0770076513156;924.2929159193222;955.5413401567148;1041.422010784007;1049.6850944716555;1055.1347894726405;18800.34198803063;18926;19313.51716207106;19467.707984380246;20014.29949951774;1000.0449570660003;1005.7737009172878;1015.5379302417382;1017.765913839821;1018.6943916824923;9499.572519236652;10955.233133680726;10962.287451315638;11011.669649910515;11130.165237607212;438488;450365;455558;457490;462213;76434.47131057459;79310;79483.60258198787;80389.59805200937;80879.19120808835;978.8531720241879;1023.5240613114937;1027.2706378471219;1028.28534168752;1061.9256652034283;17088.658226835643;17128.486145415656;17325.393611223546;17466.91266543659;17534.473965781046;37656.24687506289;37862;39207.21585568216;41776;43852.56147438485;57117;57735.71132144312;58555;58731.412685874304;59095;7980.241877021674;8083;8253.33973282148;8363.540005299767;8477.788055298666;9163.954180229057;13297.135686180367;13415.930793844267;13562.796558051834;13648.795268071186;10837.349759014169;10886.237325949796;10939.179561533076;11181.664550063511;11739.354335511629;11100.722481938015;11527.07783377311;11716.648500544998;11742.88257117418;11986.400679966142;10935.945320273348;11501.309921404743;11644.53421863116;11980.880191197977;12153.270803751802;8049.195080491904;8081.959590202011;8225.930629018188;8308.210719981593;8431.367647426345;11408.94295528517;11493.885061149282;11549.42252887369;11670.94164529172;11702.414879256174 14:37:13 INFO - PROCESS | 5086 | |3;mootools.html;1273.6051823934574;1431.1627697796791;1437.7124575084983;1517.211050253868;1714.562786489445;7754.689812407504;8093.109757926631;8124.553149576771;8348.039975402831;8353.665853365874;8033.879491807613;8200.26197642212;8204.91795082049;8204.917950820505;8207.302379297767;1970.5960278143018;2190.9890450547723;2261.34421017905;2269.954600907981;2292.8509646872985;2301.7583153768865;2311.7572654871246;2314.375118717945;2314.687517185184;2316.96524552131;2246.5506898620342;2246.786555277254;2271.0915633746467;2276.157821606008;2276.635738281875;1927.4314077347217;2042.1627132875449;2118.650422680256;2129.169623846701;2228.3649159989404;2161.778595093767;2187.8687278763164;2201.3395981205736;2207.752619769825;2208.138825857917;8235.423520353577;8345.332373410112;8371.121032291583;8373.539455329954;8384.916150838535;4776.116418462596;4906.632002599819;4910.582600478963;4916.754162291871;4917.852464426073;3042.3154790172257;3139.3564319314487;3201.15169480088;3203.3112880730755;3206.5831441912637;1017.5268500147467;1026.604757168488;1031.9793604127951;1050.4275170032352;1066.2802608239408;10911.290766100177;10932.125429965583;11012.559497620086;11015.284006539629;11041.889581104166;4232.724872883253;4261.70168088237;4274.909897976058;4318.805653745589;4337.132573485315;9360.485173315397;9371.625134994523;9398.859017114748;9402.05979402068;9403;4943.332650092263;4950.925736113961;4955.058538877602;4958.7024778513405;4960.255961605716;4157.417961485395;4510.594046535827;4638.628909687284;4646.326282688991;4725.385699858996;3708.4437334399518;3772.7924964126687;3823.2162406706557;3832.4251362295877;3882.7087968402484;1161.7386088130104;1213.6237766292477;1214.0469731261094;1216.5255550335376;1232.0328542094412;976.7167521418851;983.2527279267808;984.950752462374;987.2792861211356;990.7176454710373;5725.541956643458;5769.711514424262;5850.034744267148;5972.641641501524;6048.183495228176;912.4388501071793;935.7239614313794;937.4141161773891;949.2358651285643;970.3207754571828;4092.6725861930972;4198.706090573692;4248.596383343577;4253.978730106392;4270.316749320156;9998.850017249748;10186.286959912883;10317.638882639072;10321.638742644122;10322.535485903152;10099.495025248709;10108.292419530562;10176.847347289797;10187.286889917783;10209.336393134423;7034.648267586703;7255.165655949528;7298.671559779823;7419;7597.544147351176;5838.912416313674;5962.672053037125;6057.363976782374;6130.233720784902;6179.258488981351;9316.767080823034;9530.285228607743;9561.856572151562;9570.138687517878;9572.56923438433;8893.822123557364;9298.116678915492;9312.25501959828;9559.522023898917;9692.612295508101;6885.552439091443;7068.363847253566;7099.077119974577;7401.629918504161;7705.691772329044;7865.60671966388;7958.442908996315;8109.797255068434;8184.508929464251;8198.631061602362;7169.4981351304905;7294.708211671474;7320.414366850533;7333.669984850588;7369.484136110421;7098.503104782616;7251.311125443074;7255.891161632685;7272.527285726623;7273.854522909618;6259.843503912439;6304.5271604628915;6333.65164915934;6336.17629708135;6349.777757778455;4852.369192005017;4915.361003069578;5060.291559181644;5152.149895267239;5205.531502164823;4746.121967436035;4881.8535443936735;4955.479674634112;4966;5007.949920500749 14:37:13 INFO - PROCESS | 5086 | |4;prototype.html;309.1282583115614;311.1490074645843;314.81111333200084;315.70323895538206;317.9093958221907;5271.3147290852185;5278.3665960084745;5278.419373868871;5300.178472336789;5333.333333333333;5186.11835987882;5233.4243233244315;5234.110201265785;5234.842954711356;5247.737613119348;3797.1646237827704;3898.4152377143373;4009.6190861868076;4028.2950483665386;4081.244969680604;4033.596640335972;4040.2121586290687;4046.797660116997;4065.308897487434;4073.775942323171;3856.768593884376;4036.1433740479415;4039.838406463738;4044.211378781139;4052.358794688156;3901.161250331178;3968.603139686037;3969.28552860485;3995.960040399617;4006.8998275043064;3491.336646037245;3511.91220219494;3525.6826885580163;3528.876489322887;3532.1699400640828;5055.342805435306;5062.291279220912;5108.719020453874;5123.615728820353;5143.382794064699;4461.174682683714;4567.451905771295;4598.149342371672;4605.4473463184295;4610;5382.138857782736;5388.78444862205;5414.756335964891;5418.4039755626845;5438.782448702047;3872.7289089763726;3891.5913829047827;3894.571597124314;3901.375779875235;3919.627635374635;5437.32033495813;5625.46558076982;5628.774849006035;5631.943680563224;5639.2668953036255;3966.552208443897;3992.261431635157;3999.9400008999887;4018.9196216076098;4021.4369988201674;4007.539132999684;4043.9890027493125;4055.878323650295;4062.0657248832936;4073.9592604074173;4491.281394976853;4513.255312873404;4591.862244132682;4593.471750748707;4605.40129783126;5431.7186781551845;5461.754221060062;5467.343918729778;5472;5495.670259784426;1387.3132799264429;1406.783132590302;1412.813236881025;1417.121384741467;1417.3692706745605;902.6524787956683;913.3469569258012;932.4964519159578;956.0009789769707;958.9664361747306;5158.948410515847;5179.19722443022;5223.268742376071;5253.317068781034;5256.869772998747;5548.250986116904;5549.778008879681;5554.472325129106;5554.750036248379;5562.415946325658;5044.495550444926;5199;5212.566544200299;5229.4770522948165;5272.6836389816735;2948.3366242595675;2954.231899706092;2958.556216567489;2968.910932672023;2975.1669532530927;5475.589330800206;5716.714164291769;5728.198052272685;5738.885222295614;5742.598018138774;5564.221009058735;5607.074832652566;5608.887822243532;5640.435956404409;5663.943360566424;5640.448876558897;5660.405657405995;5664.85837854057;5675.9499492594005;5794.478496935296;5325.973370133124;5523.6685798852195;5590.972045139911;5594.3286805581965;5601.215829783752;5375.569954403716;5383.973080134574;5423.267858839006;5435.483629055233;5520.337559492726;5665.773369065356;5707.828765137053;5711.514521265739;5716.428357164416;5721.456461636138;3849.8845034649007;3990.102226998902;4000.979995100006;4002.3796311571755;4010.438538604539;5479.739659878171;5507.366652834815;5512.84230311639;5528.336599608073;5570.972145139248;5424.376196737426;5426.561961080238;5429.289773721265;5441.564674825925;5459.12653975362;5192.1183743021475;5490.584142977077;5492.203630473479;5493.807716729895;5503.587230957774;5123;5155.690658560498;5324.121519949165;5338.172583249602;5342.519173274424;5487.176923461513;5513.751881165277;5521.365043020104;5539.169124631177;5574.052411090205;5383.919241211307;5409.540189083972;5416.485433883775;5436.728163591725;5438.428964958623 14:37:13 INFO - PROCESS | 5086 | |5;yui.html;715.7591271715087;715.8675645005677;745.2733584754865;801.3909428834086;808.4987307869122;15344.156071416068;15871;16535.50393488194;16559.751603725952;16571.91714041428;14646.194459304734;15235.238238088079;15317.310721017553;15321.846781532182;15330.540083797476;663.9767608133716;785.7171418289412;792.5165648954134;799.0810567846964;800.4396922154486;771.3135309574483;801.1507801730155;807.0718673525463;808.2685169921231;809.251442415766;824.7855557555049;824.9010118785724;827.7599496146111;828.3828547731918;832.9708460203894;689.2280645676824;809.0655293136437;819.8934138561979;820.6430202861774;821.2444551013052;601.8435206846208;606.4026933470528;610.1183789424284;610.5664977865721;610.6702380714408;15741.921290393475;15763.448279310169;15777.842221577752;15789.368425262976;15798.921005395014;14563.417463301455;15030.624234394118;15057.849421505754;15149;15194.772078418833;13137.27744974026;13303.467861285633;13319.26744029078;13562.321883905865;14008.719825603534;4481.820727170909;4530.3204519322035;4562.703424277412;4725.291206319045;4731.219348807443;80857;81049;81077.59461202715;81083;81341.59329203315;11245.606403775828;11270.54917803295;11384.316940983403;11445;11787.351695656822;21971.780282197295;22054.558908821735;22082.44793880166;22096.447588810086;22124.2256521021;8289.088200297962;8337.041240257327;8493.193146651058;8522.87215691765;8683.696070637498;4808.495108013608;4972.0801651694555;4992.5756310714;5056.064628043824;5060.367454068241;3513.982430087833;3633.5458067741533;3638.3450978824067;3670;3670.9082272942856;611;628.7422156915643;636.3000699230809;637.0539748473514;637.4772686397109;558.4080874273284;582.9067349224104;732.1872721279376;739.2496615934831;753.5779963220505;9310.767230819149;9362.970073291932;9421.152096311227;9442.527873606292;9514.476703781358;551.5477308606984;622.8785386849612;644.8581312111422;655.8622689235314;665.544102289933;4505.166544189336;4606.976965115153;4663.976680116578;4680.204365257914;4825;72051;100360;125291.3735431317;126527.73472265343;128276.35861820632;58363.708181458824;59766;59910.10134847981;80724;112058.43970780094;86514;89274.55362723145;89546.10453895509;90460.5476972624;91358.08641913495;9746.707598772047;9869.555869986012;10101.191904647758;10102.191824654157;10129.139023183112;38165;51934.740326298124;52217.77302459831;53449.198262025326;54589.72705136449;51196.232056518435;55942;74755;75228.24771752213;75336;12908.677283067624;12930.418131184308;13211.603651890458;13241.62418423807;13831.100978436369;14201.28993550339;14428.134311941318;15161.848381516043;15382;15716.764248536052;13508.459661613819;13995.790063149265;14137.293135343398;14396.640083997983;14696.779548306999;14095.365708543346;14409.42362305496;14519.854801452273;15192.609377723902;15289.617759555655;13940.79088813689;14186.858131418554;14234;14316.713665726835;14331.641708957359;11585.420728963687;11671.533138674358;11851.466683999068;11908.880911190778;12360.690982725504;9955.850662240216;10130.898691012995;11237.775244495228;11864.110191735826;11865.169438139592 14:37:13 INFO - PROCESS | 5086 | __end_tp_report 14:37:13 INFO - PROCESS | 5086 | __start_cc_report 14:37:13 INFO - PROCESS | 5086 | _x_x_mozilla_cycle_collect,811 14:37:13 INFO - PROCESS | 5086 | __end_cc_report 14:37:13 INFO - PROCESS | 5086 | __startTimestamp1466199433232__endTimestamp 14:37:13 INFO - PROCESS | 5086 | 14:37:13 INFO - PROCESS | 5086 | ------- Summary: start ------- 14:37:13 INFO - PROCESS | 5086 | Number of tests: 6 14:37:13 INFO - PROCESS | 5086 | 14:37:13 INFO - PROCESS | 5086 | [#0] dojo.html Cycles:165 Average:5277.95 Median:5443.59 stddev:584.30 (10.7%) stddev-sans-first:560.32 14:37:13 INFO - PROCESS | 5086 | Values: 3090.4 3104.2 3111.2 3147.0 3159.6 5187.7 5223.9 5235.2 5340.1 5357.3 5264.9 5266.2 5325.6 5360.2 5391.2 4811.0 4862.1 4891.0 4896.7 5038.5 4948.9 4975.8 4992.6 5015.5 5035.3 4775.8 4812.2 4850.0 4855.9 4869.9 4792.5 4794.6 4798.3 4860.2 4898.4 4806.4 4817.4 4845.6 4859.2 4881.9 5206.3 5228.3 5266.4 5267.0 5361.8 5633.5 5657.1 5680.0 5695.1 5703.1 5729.7 5738.3 5742.4 5743.6 5745.1 5189.1 5256.6 5306.3 5308.6 5389.6 5855.9 5866.6 5868.9 5873.1 5874.4 5437.2 5641.2 5647.2 5649.2 5649.7 5600.0 5659.3 5660.6 5689.5 5694.7 5649.7 5656.2 5660.7 5667.7 5669.5 5548.9 5581.4 5662.3 5663.2 5666.9 4334.6 4334.6 4338.3 4350.0 4379.1 3867.5 3879.4 3892.6 3900.8 3920.0 5268.4 5335.1 5338.5 5365.1 5400.8 5654.1 5661.7 5663.3 5680.9 5724.7 5406.5 5437.0 5449.8 5455.2 5476.2 4828.2 4868.6 4918.4 4971.1 5009.3 5937.9 5943.8 5948.9 5952.9 5991.0 5726.7 5740.8 5742.0 5745.3 5748.0 5681.4 5715.5 5738.5 5797.9 5919.5 5528.6 5536.0 5543.5 5543.8 5547.7 5591.9 5610.5 5625.6 5635.3 5636.9 5432.7 5455.9 5479.6 5507.4 5558.6 5554.6 5559.6 5566.4 5567.4 5567.7 5345.8 5429.9 5441.5 5443.6 5446.2 5464.9 5516.2 5519.1 5590.3 5598.9 5408.0 5414.9 5415.3 5422.7 5423.9 14:37:13 INFO - PROCESS | 5086 | 14:37:13 INFO - PROCESS | 5086 | [#1] ext.html Cycles:180 Average:52639.44 Median:41328.07 stddev:100471.03 (243.1%) stddev-sans-first:100676.89 14:37:13 INFO - PROCESS | 5086 | Values: 596.6 612.5 616.5 633.4 642.0 32497.5 35839.8 41432.8 42235.6 42292.8 43359.3 43714.6 43825.6 43840.6 43880.8 8865.3 9017.1 9023.6 9025.1 9028.5 8870.0 8958.6 8976.3 8978.4 8979.9 8995.5 9028.3 9030.3 9030.3 9031.9 8933.6 8947.6 8955.5 8967.5 8981.3 8831.0 8879.2 8896.2 8900.4 8901.2 41815.3 42263.4 42288.6 42334.2 42350.6 3485.0 3616.4 3733.9 3752.9 3947.6 32317.7 32473.5 32637.2 32665.5 34195.8 4164.2 4366.2 4386.7 4390.6 4407.3 363565.0 365011.0 365249.0 365540.0 366740.0 33785.8 57738.0 57878.4 58000.7 58020.7 34954.3 36759.0 36760.4 36821.0 36839.0 15381.2 15570.6 15579.0 15601.2 15601.2 13034.3 13125.5 13128.8 13129.8 13146.3 8213.3 8268.5 8272.6 8300.7 8362.0 3156.9 3194.2 3212.2 3213.5 3260.5 994.7 1021.2 1026.5 1098.7 1105.3 31954.7 32348.7 32574.0 32688.0 33385.3 1110.2 1129.1 1136.7 1148.6 1236.4 16793.4 17190.5 17201.5 17340.5 17436.4 145819.0 146036.0 147475.3 510750.0 511902.0 58050.4 58446.0 58951.0 58989.1 59260.4 1230.1 1327.5 1340.1 1341.5 1396.7 29583.8 33333.8 33434.7 33712.8 33786.7 51052.0 51674.7 51762.2 52012.2 52375.0 411351.0 424648.0 426006.0 426038.0 427490.0 37637.2 38756.2 38839.8 42096.0 42436.6 45182.3 49052.8 49146.0 50067.5 50181.7 40528.8 41223.4 41854.0 42580.4 42622.0 40708.0 40781.4 41120.6 41642.6 41830.6 39736.6 40768.4 41432.8 41433.4 41552.2 33182.8 36565.3 37244.8 37462.0 37706.0 27541.4 27635.4 27823.4 28069.4 28101.0 14:37:13 INFO - PROCESS | 5086 | 14:37:13 INFO - PROCESS | 5086 | [#2] jquery.html Cycles:180 Average:27333.20 Median:37759.12 stddev:74578.38 (197.5%) stddev-sans-first:74760.13 14:37:13 INFO - PROCESS | 5086 | Values: 379.3 379.3 389.7 397.2 403.0 17658.4 19384.8 19747.7 20129.2 20145.9 18440.5 19031.8 19318.0 19386.5 19410.5 5432.3 5540.4 5681.4 5686.5 5687.4 5526.4 5591.7 5604.6 5624.8 5629.0 5471.9 5519.3 5564.0 5586.7 5662.8 5506.1 5555.3 5574.9 5594.6 5599.1 4936.6 5018.6 5064.1 5069.4 5071.4 22488.3 22606.5 22802.8 23158.8 23201.5 2979.4 3001.8 3033.6 3054.6 3160.8 7050.0 7054.9 7074.0 7078.5 7892.6 1879.9 1963.3 2025.8 2036.8 2086.6 75018.2 77005.6 77489.6 78665.2 79565.2 10190.1 10224.4 10332.2 10511.7 10670.1 14200.0 14309.9 14317.5 14340.9 14343.2 8109.0 8126.6 8239.1 8345.3 8430.9 7598.8 7604.6 8176.2 8236.7 8327.5 6279.2 6423.4 6446.8 6488.4 6489.2 1828.3 1867.9 1876.6 1892.6 1903.1 924.3 955.5 1041.4 1049.7 1055.1 18800.3 18926.0 19313.5 19467.7 20014.3 1000.0 1005.8 1015.5 1017.8 1018.7 9499.6 10955.2 10962.3 11011.7 11130.2 438488.0 450365.0 455558.0 457490.0 462213.0 76434.5 79310.0 79483.6 80389.6 80879.2 978.9 1023.5 1027.3 1028.3 1061.9 17088.7 17128.5 17325.4 17466.9 17534.5 37656.2 37862.0 39207.2 41776.0 43852.6 57117.0 57735.7 58555.0 58731.4 59095.0 7980.2 8083.0 8253.3 8363.5 8477.8 9164.0 13297.1 13415.9 13562.8 13648.8 10837.3 10886.2 10939.2 11181.7 11739.4 11100.7 11527.1 11716.6 11742.9 11986.4 10935.9 11501.3 11644.5 11980.9 12153.3 8049.2 8082.0 8225.9 8308.2 8431.4 11408.9 11493.9 11549.4 11670.9 11702.4 14:37:13 INFO - PROCESS | 5086 | 14:37:13 INFO - PROCESS | 5086 | [#3] mootools.html Cycles:180 Average:5447.72 Median:4955.27 stddev:3019.17 (60.9%) stddev-sans-first:3011.34 14:37:13 INFO - PROCESS | 5086 | Values: 1273.6 1431.2 1437.7 1517.2 1714.6 7754.7 8093.1 8124.6 8348.0 8353.7 8033.9 8200.3 8204.9 8204.9 8207.3 1970.6 2191.0 2261.3 2270.0 2292.9 2301.8 2311.8 2314.4 2314.7 2317.0 2246.6 2246.8 2271.1 2276.2 2276.6 1927.4 2042.2 2118.7 2129.2 2228.4 2161.8 2187.9 2201.3 2207.8 2208.1 8235.4 8345.3 8371.1 8373.5 8384.9 4776.1 4906.6 4910.6 4916.8 4917.9 3042.3 3139.4 3201.2 3203.3 3206.6 1017.5 1026.6 1032.0 1050.4 1066.3 10911.3 10932.1 11012.6 11015.3 11041.9 4232.7 4261.7 4274.9 4318.8 4337.1 9360.5 9371.6 9398.9 9402.1 9403.0 4943.3 4950.9 4955.1 4958.7 4960.3 4157.4 4510.6 4638.6 4646.3 4725.4 3708.4 3772.8 3823.2 3832.4 3882.7 1161.7 1213.6 1214.0 1216.5 1232.0 976.7 983.3 985.0 987.3 990.7 5725.5 5769.7 5850.0 5972.6 6048.2 912.4 935.7 937.4 949.2 970.3 4092.7 4198.7 4248.6 4254.0 4270.3 9998.9 10186.3 10317.6 10321.6 10322.5 10099.5 10108.3 10176.8 10187.3 10209.3 7034.6 7255.2 7298.7 7419.0 7597.5 5838.9 5962.7 6057.4 6130.2 6179.3 9316.8 9530.3 9561.9 9570.1 9572.6 8893.8 9298.1 9312.3 9559.5 9692.6 6885.6 7068.4 7099.1 7401.6 7705.7 7865.6 7958.4 8109.8 8184.5 8198.6 7169.5 7294.7 7320.4 7333.7 7369.5 7098.5 7251.3 7255.9 7272.5 7273.9 6259.8 6304.5 6333.7 6336.2 6349.8 4852.4 4915.4 5060.3 5152.1 5205.5 4746.1 4881.9 4955.5 4966.0 5007.9 14:37:13 INFO - PROCESS | 5086 | 14:37:13 INFO - PROCESS | 5086 | [#4] prototype.html Cycles:180 Average:4567.94 Median:5255.09 stddev:1341.65 (25.5%) stddev-sans-first:1306.78 14:37:13 INFO - PROCESS | 5086 | Values: 309.1 311.1 314.8 315.7 317.9 5271.3 5278.4 5278.4 5300.2 5333.3 5186.1 5233.4 5234.1 5234.8 5247.7 3797.2 3898.4 4009.6 4028.3 4081.2 4033.6 4040.2 4046.8 4065.3 4073.8 3856.8 4036.1 4039.8 4044.2 4052.4 3901.2 3968.6 3969.3 3996.0 4006.9 3491.3 3511.9 3525.7 3528.9 3532.2 5055.3 5062.3 5108.7 5123.6 5143.4 4461.2 4567.5 4598.1 4605.4 4610.0 5382.1 5388.8 5414.8 5418.4 5438.8 3872.7 3891.6 3894.6 3901.4 3919.6 5437.3 5625.5 5628.8 5631.9 5639.3 3966.6 3992.3 3999.9 4018.9 4021.4 4007.5 4044.0 4055.9 4062.1 4074.0 4491.3 4513.3 4591.9 4593.5 4605.4 5431.7 5461.8 5467.3 5472.0 5495.7 1387.3 1406.8 1412.8 1417.1 1417.4 902.7 913.3 932.5 956.0 959.0 5158.9 5179.2 5223.3 5253.3 5256.9 5548.3 5549.8 5554.5 5554.8 5562.4 5044.5 5199.0 5212.6 5229.5 5272.7 2948.3 2954.2 2958.6 2968.9 2975.2 5475.6 5716.7 5728.2 5738.9 5742.6 5564.2 5607.1 5608.9 5640.4 5663.9 5640.4 5660.4 5664.9 5675.9 5794.5 5326.0 5523.7 5591.0 5594.3 5601.2 5375.6 5384.0 5423.3 5435.5 5520.3 5665.8 5707.8 5711.5 5716.4 5721.5 3849.9 3990.1 4001.0 4002.4 4010.4 5479.7 5507.4 5512.8 5528.3 5571.0 5424.4 5426.6 5429.3 5441.6 5459.1 5192.1 5490.6 5492.2 5493.8 5503.6 5123.0 5155.7 5324.1 5338.2 5342.5 5487.2 5513.8 5521.4 5539.2 5574.1 5383.9 5409.5 5416.5 5436.7 5438.4 14:37:13 INFO - PROCESS | 5086 | 14:37:13 INFO - PROCESS | 5086 | [#5] yui.html Cycles:180 Average:20199.29 Median:4728.26 stddev:28446.50 (601.6%) stddev-sans-first:28488.68 14:37:13 INFO - PROCESS | 5086 | Values: 715.8 715.9 745.3 801.4 808.5 15344.2 15871.0 16535.5 16559.8 16571.9 14646.2 15235.2 15317.3 15321.8 15330.5 664.0 785.7 792.5 799.1 800.4 771.3 801.2 807.1 808.3 809.3 824.8 824.9 827.8 828.4 833.0 689.2 809.1 819.9 820.6 821.2 601.8 606.4 610.1 610.6 610.7 15741.9 15763.4 15777.8 15789.4 15798.9 14563.4 15030.6 15057.8 15149.0 15194.8 13137.3 13303.5 13319.3 13562.3 14008.7 4481.8 4530.3 4562.7 4725.3 4731.2 80857.0 81049.0 81077.6 81083.0 81341.6 11245.6 11270.5 11384.3 11445.0 11787.4 21971.8 22054.6 22082.4 22096.4 22124.2 8289.1 8337.0 8493.2 8522.9 8683.7 4808.5 4972.1 4992.6 5056.1 5060.4 3514.0 3633.5 3638.3 3670.0 3670.9 611.0 628.7 636.3 637.1 637.5 558.4 582.9 732.2 739.2 753.6 9310.8 9363.0 9421.2 9442.5 9514.5 551.5 622.9 644.9 655.9 665.5 4505.2 4607.0 4664.0 4680.2 4825.0 72051.0 100360.0 125291.4 126527.7 128276.4 58363.7 59766.0 59910.1 80724.0 112058.4 86514.0 89274.6 89546.1 90460.5 91358.1 9746.7 9869.6 10101.2 10102.2 10129.1 38165.0 51934.7 52217.8 53449.2 54589.7 51196.2 55942.0 74755.0 75228.2 75336.0 12908.7 12930.4 13211.6 13241.6 13831.1 14201.3 14428.1 15161.8 15382.0 15716.8 13508.5 13995.8 14137.3 14396.6 14696.8 14095.4 14409.4 14519.9 15192.6 15289.6 13940.8 14186.9 14234.0 14316.7 14331.6 11585.4 11671.5 11851.5 11908.9 12360.7 9955.9 10130.9 11237.8 11864.1 11865.2 14:37:13 INFO - PROCESS | 5086 | -------- Summary: end -------- 14:37:13 INFO - PROCESS | 5086 | 14:37:14 INFO - TEST-INFO | 5086: exit 0 14:37:14 INFO - TEST-OK | dromaeo_css | took 1113853ms 14:37:14 INFO - TEST-START | kraken 14:37:14 INFO - operating with platform_type : linux_ 14:37:14 INFO - Initialising browser for kraken test... 14:37:14 INFO - TEST-INFO | started process 5263 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXT0WUS/profile http://localhost:50864/getInfo.html) 14:37:17 INFO - PROCESS | 5263 | __metrics Screen width/height:1600/1200 14:37:17 INFO - PROCESS | 5263 | colorDepth:24 14:37:17 INFO - PROCESS | 5263 | Browser inner width/height: 1024/697 14:37:17 INFO - PROCESS | 5263 | __metrics 14:37:18 INFO - PROCESS | 5263 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:37:19 INFO - TEST-INFO | 5263: exit 0 14:37:19 INFO - Browser initialized. 14:37:19 INFO - Running cycle 1/1 for kraken test... 14:37:19 INFO - TEST-INFO | started process 5345 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXT0WUS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:37:31 INFO - PROCESS | 5345 | RSS: Main: 173928448 14:37:31 INFO - PROCESS | 5345 | 14:37:34 INFO - PROCESS | 5345 | Cycle 1(1): loaded http://localhost:50864/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50864/tests/kraken/driver.html?testName=audio-beat-detection) 14:37:34 INFO - PROCESS | 5345 | RSS: Main: 232468480 14:37:34 INFO - PROCESS | 5345 | 14:37:37 INFO - PROCESS | 5345 | Cycle 1(1): loaded http://localhost:50864/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50864/tests/kraken/driver.html?testName=audio-dft) 14:37:38 INFO - PROCESS | 5345 | RSS: Main: 221425664 14:37:38 INFO - PROCESS | 5345 | 14:37:41 INFO - PROCESS | 5345 | Cycle 1(1): loaded http://localhost:50864/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50864/tests/kraken/driver.html?testName=audio-fft) 14:37:42 INFO - PROCESS | 5345 | RSS: Main: 286879744 14:37:42 INFO - PROCESS | 5345 | 14:37:44 INFO - PROCESS | 5345 | Cycle 1(1): loaded http://localhost:50864/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50864/tests/kraken/driver.html?testName=audio-oscillator) 14:37:44 INFO - PROCESS | 5345 | RSS: Main: 197328896 14:37:44 INFO - PROCESS | 5345 | 14:37:46 INFO - PROCESS | 5345 | Cycle 1(1): loaded http://localhost:50864/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50864/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:37:47 INFO - PROCESS | 5345 | RSS: Main: 201953280 14:37:47 INFO - PROCESS | 5345 | 14:37:50 INFO - PROCESS | 5345 | Cycle 1(1): loaded http://localhost:50864/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50864/tests/kraken/driver.html?testName=imaging-darkroom) 14:37:51 INFO - PROCESS | 5345 | RSS: Main: 237568000 14:37:51 INFO - PROCESS | 5345 | 14:37:54 INFO - PROCESS | 5345 | Cycle 1(1): loaded http://localhost:50864/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50864/tests/kraken/driver.html?testName=imaging-desaturate) 14:37:55 INFO - PROCESS | 5345 | RSS: Main: 238403584 14:37:55 INFO - PROCESS | 5345 | 14:37:58 INFO - PROCESS | 5345 | Cycle 1(1): loaded http://localhost:50864/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50864/tests/kraken/driver.html?testName=json-parse-financial) 14:37:58 INFO - PROCESS | 5345 | RSS: Main: 238370816 14:37:58 INFO - PROCESS | 5345 | 14:38:00 INFO - PROCESS | 5345 | Cycle 1(1): loaded http://localhost:50864/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50864/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:38:00 INFO - PROCESS | 5345 | RSS: Main: 227508224 14:38:00 INFO - PROCESS | 5345 | 14:38:02 INFO - PROCESS | 5345 | Cycle 1(1): loaded http://localhost:50864/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50864/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:38:03 INFO - PROCESS | 5345 | RSS: Main: 229924864 14:38:03 INFO - PROCESS | 5345 | 14:38:05 INFO - PROCESS | 5345 | Cycle 1(1): loaded http://localhost:50864/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50864/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:38:05 INFO - PROCESS | 5345 | RSS: Main: 237490176 14:38:05 INFO - PROCESS | 5345 | 14:38:08 INFO - PROCESS | 5345 | Cycle 1(1): loaded http://localhost:50864/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50864/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:38:09 INFO - PROCESS | 5345 | RSS: Main: 240025600 14:38:09 INFO - PROCESS | 5345 | 14:38:11 INFO - PROCESS | 5345 | Cycle 1(1): loaded http://localhost:50864/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50864/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:38:12 INFO - PROCESS | 5345 | RSS: Main: 241168384 14:38:12 INFO - PROCESS | 5345 | 14:38:14 INFO - PROCESS | 5345 | Cycle 1(1): loaded http://localhost:50864/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50864/tests/kraken/driver.html?testName=ai-astar) 14:38:14 INFO - PROCESS | 5345 | RSS: Main: 282857472 14:38:14 INFO - PROCESS | 5345 | 14:38:14 INFO - PROCESS | 5345 | __start_tp_report 14:38:14 INFO - PROCESS | 5345 | _x_x_mozilla_page_load 14:38:14 INFO - PROCESS | 5345 | _x_x_mozilla_page_load_details 14:38:14 INFO - PROCESS | 5345 | |i|pagename|runs| 14:38:14 INFO - PROCESS | 5345 | |0;ai-astar;110;104;112;110;111;111;110;110;110;111 14:38:14 INFO - PROCESS | 5345 | |1;audio-beat-detection;153;131;139;185;126;170;162;127;184;127 14:38:14 INFO - PROCESS | 5345 | |2;audio-dft;160;162;160;162;161;163;163;163;162;163 14:38:14 INFO - PROCESS | 5345 | |3;audio-fft;74;75;76;131;83;77;76;76;100;74 14:38:14 INFO - PROCESS | 5345 | |4;audio-oscillator;85;84;113;87;87;85;128;86;86;130 14:38:14 INFO - PROCESS | 5345 | |5;imaging-gaussian-blur;116;117;117;116;117;116;117;117;117;117 14:38:14 INFO - PROCESS | 5345 | |6;imaging-darkroom;145;145;146;146;145;145;146;146;145;146 14:38:14 INFO - PROCESS | 5345 | |7;imaging-desaturate;95;95;95;95;95;94;95;95;95;95 14:38:14 INFO - PROCESS | 5345 | |8;json-parse-financial;57;57;56;55;58;55;56;55;56;56 14:38:14 INFO - PROCESS | 5345 | |9;json-stringify-tinderbox;62;63;63;63;63;63;62;62;62;63 14:38:14 INFO - PROCESS | 5345 | |10;stanford-crypto-aes;80;78;79;79;80;81;83;81;111;82 14:38:14 INFO - PROCESS | 5345 | |11;stanford-crypto-ccm;123;122;129;120;132;120;126;120;143;124 14:38:14 INFO - PROCESS | 5345 | |12;stanford-crypto-pbkdf2;165;160;160;162;161;160;161;170;158;164 14:38:14 INFO - PROCESS | 5345 | |13;stanford-crypto-sha256-iterative;65;65;65;64;64;64;65;64;62;66 14:38:14 INFO - PROCESS | 5345 | __end_tp_report 14:38:14 INFO - PROCESS | 5345 | __start_cc_report 14:38:14 INFO - PROCESS | 5345 | _x_x_mozilla_cycle_collect,1628 14:38:14 INFO - PROCESS | 5345 | __end_cc_report 14:38:14 INFO - PROCESS | 5345 | __startTimestamp1466199494316__endTimestamp 14:38:14 INFO - PROCESS | 5345 | 14:38:14 INFO - PROCESS | 5345 | ------- Summary: start ------- 14:38:14 INFO - PROCESS | 5345 | Number of tests: 14 14:38:14 INFO - PROCESS | 5345 | 14:38:14 INFO - PROCESS | 5345 | [#0] ai-astar Cycles:10 Average:109.90 Median:110.50 stddev:2.18 (2.0%) stddev-sans-first:2.32 14:38:14 INFO - PROCESS | 5345 | Values: 110.0 104.0 112.0 110.0 111.0 111.0 110.0 110.0 110.0 111.0 14:38:14 INFO - PROCESS | 5345 | 14:38:14 INFO - PROCESS | 5345 | [#1] audio-beat-detection Cycles:10 Average:150.40 Median:157.50 stddev:23.68 (15.0%) stddev-sans-first:25.10 14:38:14 INFO - PROCESS | 5345 | Values: 153.0 131.0 139.0 185.0 126.0 170.0 162.0 127.0 184.0 127.0 14:38:14 INFO - PROCESS | 5345 | 14:38:14 INFO - PROCESS | 5345 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.50 stddev:1.20 (0.7%) stddev-sans-first:1.05 14:38:14 INFO - PROCESS | 5345 | Values: 160.0 162.0 160.0 162.0 161.0 163.0 163.0 163.0 162.0 163.0 14:38:14 INFO - PROCESS | 5345 | 14:38:14 INFO - PROCESS | 5345 | [#3] audio-fft Cycles:10 Average:84.20 Median:76.00 stddev:18.22 (24.0%) stddev-sans-first:18.95 14:38:14 INFO - PROCESS | 5345 | Values: 74.0 75.0 76.0 131.0 83.0 77.0 76.0 76.0 100.0 74.0 14:38:14 INFO - PROCESS | 5345 | 14:38:14 INFO - PROCESS | 5345 | [#4] audio-oscillator Cycles:10 Average:97.10 Median:85.50 stddev:18.87 (22.1%) stddev-sans-first:19.50 14:38:14 INFO - PROCESS | 5345 | Values: 85.0 84.0 113.0 87.0 87.0 85.0 128.0 86.0 86.0 130.0 14:38:14 INFO - PROCESS | 5345 | 14:38:14 INFO - PROCESS | 5345 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 14:38:14 INFO - PROCESS | 5345 | Values: 116.0 117.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 14:38:14 INFO - PROCESS | 5345 | 14:38:14 INFO - PROCESS | 5345 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 14:38:14 INFO - PROCESS | 5345 | Values: 145.0 145.0 146.0 146.0 145.0 145.0 146.0 146.0 145.0 146.0 14:38:14 INFO - PROCESS | 5345 | 14:38:14 INFO - PROCESS | 5345 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 14:38:14 INFO - PROCESS | 5345 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 14:38:14 INFO - PROCESS | 5345 | 14:38:14 INFO - PROCESS | 5345 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:56.00 stddev:0.99 (1.8%) stddev-sans-first:1.00 14:38:14 INFO - PROCESS | 5345 | Values: 57.0 57.0 56.0 55.0 58.0 55.0 56.0 55.0 56.0 56.0 14:38:14 INFO - PROCESS | 5345 | 14:38:14 INFO - PROCESS | 5345 | [#9] json-stringify-tinderbox Cycles:10 Average:62.60 Median:63.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 14:38:14 INFO - PROCESS | 5345 | Values: 62.0 63.0 63.0 63.0 63.0 63.0 62.0 62.0 62.0 63.0 14:38:14 INFO - PROCESS | 5345 | 14:38:14 INFO - PROCESS | 5345 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:80.50 stddev:9.81 (12.2%) stddev-sans-first:10.33 14:38:14 INFO - PROCESS | 5345 | Values: 80.0 78.0 79.0 79.0 80.0 81.0 83.0 81.0 111.0 82.0 14:38:14 INFO - PROCESS | 5345 | 14:38:14 INFO - PROCESS | 5345 | [#11] stanford-crypto-ccm Cycles:10 Average:125.90 Median:125.00 stddev:7.23 (5.8%) stddev-sans-first:7.60 14:38:14 INFO - PROCESS | 5345 | Values: 123.0 122.0 129.0 120.0 132.0 120.0 126.0 120.0 143.0 124.0 14:38:14 INFO - PROCESS | 5345 | 14:38:14 INFO - PROCESS | 5345 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.10 Median:161.50 stddev:3.45 (2.1%) stddev-sans-first:3.49 14:38:14 INFO - PROCESS | 5345 | Values: 165.0 160.0 160.0 162.0 161.0 160.0 161.0 170.0 158.0 164.0 14:38:14 INFO - PROCESS | 5345 | 14:38:14 INFO - PROCESS | 5345 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.40 Median:65.00 stddev:1.07 (1.7%) stddev-sans-first:1.12 14:38:14 INFO - PROCESS | 5345 | Values: 65.0 65.0 65.0 64.0 64.0 64.0 65.0 64.0 62.0 66.0 14:38:14 INFO - PROCESS | 5345 | -------- Summary: end -------- 14:38:14 INFO - PROCESS | 5345 | 14:38:15 INFO - TEST-INFO | 5345: exit 0 14:38:15 INFO - TEST-OK | kraken | took 61266ms 14:38:15 INFO - SUITE-END | took 1175s 14:38:15 INFO - Completed test suite (00:19:35) 14:38:15 INFO - javascript benchmark 14:38:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3090.4128215639025, 3104.161876293401, 3111.1599868035632, 3147.040152753409, 3159.6366417861936, 5187.714675692835, 5223.947760522394, 5235.162374020158, 5340.145576707728, 5357.303550538424, 5264.894702105956, 5266.236395722618, 5325.600579956499, 5360.249565060894, 5391.16436952272, 4810.951890481103, 4862.051899879525, 4890.951090489085, 4896.706197628136, 5038.521340472649, 4948.851534453972, 4975.751212439382, 4992.550670439659, 5015.498450154973, 5035.345405097332, 4775.808967641307, 4812.205986012304, 4849.9757501212625, 4855.878603034917, 4869.8782530436665, 4792.544708252711, 4794.568488836021, 4798.328234047236, 4860.246661767432, 4898.387701537308, 4806.447258565275, 4817.4219093708625, 4845.6123510119105, 4859.246816743375, 4881.8535443936735, 5206.323177986876, 5228.294180285651, 5266.394364648077, 5267.0, 5361.785528578852, 5633.492985631313, 5657.09486482165, 5679.971600142014, 5695.088785794253, 5703.116017017369, 5729.684867332295, 5738.340090889559, 5742.368339482654, 5743.597948143632, 5745.080787074048, 5189.091908915962, 5256.6057545684225, 5306.336707911511, 5308.601854860863, 5389.649672771257, 5855.882882342329, 5866.560007999417, 5868.853278668067, 5873.089671100986, 5874.441928016831, 5437.238786569884, 5641.238432811518, 5647.209390685307, 5649.209110724501, 5649.745761440745, 5599.972000139973, 5659.320881494247, 5660.575456840754, 5689.459501347365, 5694.715264236772, 5649.661020338793, 5656.179853921159, 5660.660360378391, 5667.659940403507, 5669.546436285087, 5548.91676624851, 5581.413951535112, 5662.292213473316, 5663.1505274208375, 5666.886662266732, 4334.5882141196535, 4334.631556317749, 4338.284183109751, 4350.0, 4379.146066516999, 3867.5358956925347, 3879.437481565157, 3892.5523564789846, 3900.8010840540455, 3919.980400097981, 5268.420473747885, 5335.0663633863915, 5338.492843179892, 5365.061114304981, 5400.756965936543, 5654.095344744904, 5661.66030038199, 5663.263775709213, 5680.943190568124, 5724.656520608777, 5406.486383793534, 5436.972815135899, 5449.782008719607, 5455.1544510600925, 5476.17857321405, 4828.179209534387, 4868.561829435368, 4918.360613120271, 4971.055499455092, 5009.273655319958, 5937.881242375129, 5943.791967281211, 5948.85127871798, 5952.8809423812145, 5991.0, 5726.656400615976, 5740.827775166752, 5741.971290143522, 5745.2818397700285, 5748.0, 5681.4034526374135, 5715.457031581993, 5738.483536481736, 5797.9420205797405, 5919.467247947706, 5528.640638358494, 5535.972320138373, 5543.501084902378, 5543.805966791143, 5547.694876781816, 5591.8881622368135, 5610.4670056344585, 5625.606207565431, 5635.295588051494, 5636.915446268227, 5432.728363581726, 5455.863603409946, 5479.643823151482, 5507.394186639546, 5558.555315574664, 5554.555635549227, 5559.610827242216, 5566.443355664401, 5567.4432556744005, 5567.7494512747835, 5345.839624811262, 5429.864253393539, 5441.5374693151525, 5443.59173062014, 5446.155845843742, 5464.890702185855, 5516.172574113915, 5519.144532597454, 5590.329160500766, 5598.944010560005, 5408.0, 5414.891702165856, 5415.2689386933835, 5422.674639521641, 5423.9186412204635], "value": 5239.56326711631, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.5645079092262, 612.4702132655253, 616.4883146988001, 633.3666333666333, 641.9903701444479, 32497.51253731193, 35839.82080089599, 41432.79283603586, 42235.57764422355, 42292.788536057276, 43359.3496097558, 43714.56285437145, 43825.56174438255, 43840.561594384126, 43880.78059609706, 8865.290776737846, 9017.143371379741, 9023.593938272761, 9025.052369501174, 9028.458292502439, 8870.024297327322, 8958.596863141174, 8976.326775491832, 8978.41640293382, 8979.910200898006, 8995.5052472114, 9028.32287578431, 9030.322725795559, 9030.322725795559, 9031.909680903205, 8933.55332233389, 8947.552622368856, 8955.507447090407, 8967.506787126673, 8981.326400519922, 8831.0, 8879.200871921557, 8896.199342059246, 8900.37697361185, 8901.243394311427, 41815.327386904486, 42263.366049509284, 42288.57711422877, 42334.1533169338, 42350.57649423497, 3485.041613556267, 3616.439451884962, 3733.906652333686, 3752.868649597251, 3947.6447119759073, 32317.6768232317, 32473.51289730656, 32637.184070398194, 32665.51001734976, 34195.82902085499, 4164.229617520738, 4366.170427618742, 4386.69119141701, 4390.626796722282, 4407.259132642588, 363565.0, 365011.0, 365249.0, 365539.9999999973, 366740.0, 33785.83107084449, 57738.0, 57878.421215787304, 58000.70999644975, 58020.70989645025, 34954.300913982086, 36759.0, 36760.448593271125, 36821.0, 36839.0, 15381.230938453033, 15570.610734731723, 15579.0, 15601.219939003004, 15601.219939003231, 13034.348282585834, 13125.540606078932, 13128.803067953988, 13129.803052954214, 13146.27695476758, 8213.260806527442, 8268.462549934235, 8272.627731752085, 8300.70947516834, 8361.95819020901, 3156.921076973048, 3194.1535493094348, 3212.213007813101, 3213.5179723041265, 3260.4620237660993, 994.6767300627325, 1021.1575450253571, 1026.5021464589668, 1098.7308109513222, 1105.2539535813455, 31954.68045319517, 32348.676513235037, 32574.0, 32688.0, 33385.332293354, 1110.1951085462974, 1129.1136457880525, 1136.7499150187111, 1148.5520646947698, 1236.3632729144497, 16793.41223057187, 17190.484285471455, 17201.45186933182, 17340.4797856062, 17436.422971305736, 145819.0, 146036.0, 147475.2626236862, 510750.0, 511902.0, 58050.41949580535, 58445.99999999915, 58951.0, 58989.10108989067, 59260.40739592635, 1230.0712961713848, 1327.5353626230935, 1340.1155237543176, 1341.5170538606094, 1396.71367369691, 29583.816647333864, 33333.83333083416, 33434.66565334315, 33712.831435842665, 33786.662133378355, 51052.0, 51674.74162629163, 51762.223566647284, 52012.219816702025, 52375.0, 411351.0, 424648.0, 426006.0, 426038.0, 427490.0, 37637.2472550542, 38756.224875501764, 38839.80580097081, 42096.0, 42436.575634243265, 45182.32226516539, 49052.75473622609, 49146.0, 50067.49932500628, 50181.74909125431, 40528.797356013034, 41223.381649274685, 41854.0, 42580.36129458123, 42622.0, 40708.0, 40781.388279176426, 41120.588794112875, 41642.58357416508, 41830.58169418267, 39736.59678283132, 40768.388474172316, 41432.75701728953, 41433.37849932193, 41552.168956620095, 33182.83408582942, 36565.26869462649, 37244.81377593095, 37462.0, 37706.0, 27541.44917101687, 27635.44729105447, 27823.443531128858, 28069.43861122725, 28101.0], "value": 18844.43096828208, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.2869405517627, 379.3456287903367, 389.67267495303946, 397.21549938870714, 402.98992525186867, 17658.381956631503, 19384.806151938476, 19747.703784443227, 20129.194832206693, 20145.899270503665, 18440.538986525342, 19031.809681903178, 19318.0, 19386.51533711658, 19410.51473713158, 5432.320959880015, 5540.36285827129, 5681.403452637475, 5686.459786320293, 5687.374388817227, 5526.392096869341, 5591.692456914868, 5604.551635869121, 5624.831255062334, 5628.971855140739, 5471.863203419906, 5519.31008623922, 5564.0, 5586.692731899744, 5662.773489060432, 5506.119020956648, 5555.3333599967855, 5574.888502229973, 5594.636348637326, 5599.076152434844, 4936.570461455486, 5018.64869459138, 5064.088464076464, 5069.417017043013, 5071.391433028023, 22488.32535023952, 22606.54786904269, 22802.771972280232, 23158.768412316, 23201.53596928052, 2979.3743313903888, 3001.8048826826184, 3033.635963684372, 3054.6487153977355, 3160.7787454878166, 7050.0482434871665, 7054.929450705478, 7074.045003924456, 7078.539894906815, 7892.644830982619, 1879.8590105742123, 1963.3128405058258, 2025.8480613954011, 2036.8268697160759, 2086.613976414353, 75018.21263436512, 77005.61497192478, 77489.61255193745, 78665.21334786693, 79565.20434795636, 10190.133838623651, 10224.437655928847, 10332.225083118796, 10511.737206569896, 10670.093042091508, 14200.0, 14309.856901430852, 14317.498887538886, 14340.856591434162, 14343.211123388313, 8108.959455202804, 8126.55303958288, 8239.134890836496, 8345.290650294794, 8430.915690843136, 7598.772036838904, 7604.619769011527, 8176.223258790405, 8236.711715090063, 8327.541985190872, 6279.215098112736, 6423.389777971085, 6446.774362897276, 6488.442773734364, 6489.1888513935755, 1828.31438210671, 1867.8979402152795, 1876.5777700017659, 1892.649859775946, 1903.0770076513156, 924.2929159193222, 955.5413401567148, 1041.422010784007, 1049.6850944716555, 1055.1347894726405, 18800.34198803063, 18926.0, 19313.51716207106, 19467.707984380246, 20014.29949951774, 1000.0449570660003, 1005.7737009172878, 1015.5379302417382, 1017.765913839821, 1018.6943916824923, 9499.572519236652, 10955.233133680726, 10962.287451315638, 11011.669649910515, 11130.165237607212, 438488.0, 450365.0, 455558.0, 457490.0, 462213.0, 76434.47131057459, 79310.0, 79483.60258198787, 80389.59805200937, 80879.19120808835, 978.8531720241879, 1023.5240613114937, 1027.2706378471219, 1028.28534168752, 1061.9256652034283, 17088.658226835643, 17128.486145415656, 17325.393611223546, 17466.91266543659, 17534.473965781046, 37656.24687506289, 37862.0, 39207.21585568216, 41776.0, 43852.56147438485, 57117.0, 57735.71132144312, 58555.0, 58731.412685874304, 59095.0, 7980.241877021674, 8083.0, 8253.33973282148, 8363.540005299767, 8477.788055298666, 9163.954180229057, 13297.135686180367, 13415.930793844267, 13562.796558051834, 13648.795268071186, 10837.349759014169, 10886.237325949796, 10939.179561533076, 11181.664550063511, 11739.354335511629, 11100.722481938015, 11527.07783377311, 11716.648500544998, 11742.88257117418, 11986.400679966142, 10935.945320273348, 11501.309921404743, 11644.53421863116, 11980.880191197977, 12153.270803751802, 8049.195080491904, 8081.959590202011, 8225.930629018188, 8308.210719981593, 8431.367647426345, 11408.94295528517, 11493.885061149282, 11549.42252887369, 11670.94164529172, 11702.414879256174], "value": 9074.242479555483, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1273.6051823934574, 1431.1627697796791, 1437.7124575084983, 1517.211050253868, 1714.562786489445, 7754.689812407504, 8093.109757926631, 8124.553149576771, 8348.039975402831, 8353.665853365874, 8033.879491807613, 8200.26197642212, 8204.91795082049, 8204.917950820505, 8207.302379297767, 1970.5960278143018, 2190.9890450547723, 2261.34421017905, 2269.954600907981, 2292.8509646872985, 2301.7583153768865, 2311.7572654871246, 2314.375118717945, 2314.687517185184, 2316.96524552131, 2246.5506898620342, 2246.786555277254, 2271.0915633746467, 2276.157821606008, 2276.635738281875, 1927.4314077347217, 2042.1627132875449, 2118.650422680256, 2129.169623846701, 2228.3649159989404, 2161.778595093767, 2187.8687278763164, 2201.3395981205736, 2207.752619769825, 2208.138825857917, 8235.423520353577, 8345.332373410112, 8371.121032291583, 8373.539455329954, 8384.916150838535, 4776.116418462596, 4906.632002599819, 4910.582600478963, 4916.754162291871, 4917.852464426073, 3042.3154790172257, 3139.3564319314487, 3201.15169480088, 3203.3112880730755, 3206.5831441912637, 1017.5268500147467, 1026.604757168488, 1031.9793604127951, 1050.4275170032352, 1066.2802608239408, 10911.290766100177, 10932.125429965583, 11012.559497620086, 11015.284006539629, 11041.889581104166, 4232.724872883253, 4261.70168088237, 4274.909897976058, 4318.805653745589, 4337.132573485315, 9360.485173315397, 9371.625134994523, 9398.859017114748, 9402.05979402068, 9403.0, 4943.332650092263, 4950.925736113961, 4955.058538877602, 4958.7024778513405, 4960.255961605716, 4157.417961485395, 4510.594046535827, 4638.628909687284, 4646.326282688991, 4725.385699858996, 3708.4437334399518, 3772.7924964126687, 3823.2162406706557, 3832.4251362295877, 3882.7087968402484, 1161.7386088130104, 1213.6237766292477, 1214.0469731261094, 1216.5255550335376, 1232.0328542094412, 976.7167521418851, 983.2527279267808, 984.950752462374, 987.2792861211356, 990.7176454710373, 5725.541956643458, 5769.711514424262, 5850.034744267148, 5972.641641501524, 6048.183495228176, 912.4388501071793, 935.7239614313794, 937.4141161773891, 949.2358651285643, 970.3207754571828, 4092.6725861930972, 4198.706090573692, 4248.596383343577, 4253.978730106392, 4270.316749320156, 9998.850017249748, 10186.286959912883, 10317.638882639072, 10321.638742644122, 10322.535485903152, 10099.495025248709, 10108.292419530562, 10176.847347289797, 10187.286889917783, 10209.336393134423, 7034.648267586703, 7255.165655949528, 7298.671559779823, 7419.0, 7597.544147351176, 5838.912416313674, 5962.672053037125, 6057.363976782374, 6130.233720784902, 6179.258488981351, 9316.767080823034, 9530.285228607743, 9561.856572151562, 9570.138687517878, 9572.56923438433, 8893.822123557364, 9298.116678915492, 9312.25501959828, 9559.522023898917, 9692.612295508101, 6885.552439091443, 7068.363847253566, 7099.077119974577, 7401.629918504161, 7705.691772329044, 7865.60671966388, 7958.442908996315, 8109.797255068434, 8184.508929464251, 8198.631061602362, 7169.4981351304905, 7294.708211671474, 7320.414366850533, 7333.669984850588, 7369.484136110421, 7098.503104782616, 7251.311125443074, 7255.891161632685, 7272.527285726623, 7273.854522909618, 6259.843503912439, 6304.5271604628915, 6333.65164915934, 6336.17629708135, 6349.777757778455, 4852.369192005017, 4915.361003069578, 5060.291559181644, 5152.149895267239, 5205.531502164823, 4746.121967436035, 4881.8535443936735, 4955.479674634112, 4966.0, 5007.949920500749], "value": 4396.653641221281, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.1282583115614, 311.1490074645843, 314.81111333200084, 315.70323895538206, 317.9093958221907, 5271.3147290852185, 5278.3665960084745, 5278.419373868871, 5300.178472336789, 5333.333333333333, 5186.11835987882, 5233.4243233244315, 5234.110201265785, 5234.842954711356, 5247.737613119348, 3797.1646237827704, 3898.4152377143373, 4009.6190861868076, 4028.2950483665386, 4081.244969680604, 4033.596640335972, 4040.2121586290687, 4046.797660116997, 4065.308897487434, 4073.775942323171, 3856.768593884376, 4036.1433740479415, 4039.838406463738, 4044.211378781139, 4052.358794688156, 3901.161250331178, 3968.603139686037, 3969.28552860485, 3995.960040399617, 4006.8998275043064, 3491.336646037245, 3511.91220219494, 3525.6826885580163, 3528.876489322887, 3532.1699400640828, 5055.342805435306, 5062.291279220912, 5108.719020453874, 5123.615728820353, 5143.382794064699, 4461.174682683714, 4567.451905771295, 4598.149342371672, 4605.4473463184295, 4610.0, 5382.138857782736, 5388.78444862205, 5414.756335964891, 5418.4039755626845, 5438.782448702047, 3872.7289089763726, 3891.5913829047827, 3894.571597124314, 3901.375779875235, 3919.627635374635, 5437.32033495813, 5625.46558076982, 5628.774849006035, 5631.943680563224, 5639.2668953036255, 3966.552208443897, 3992.261431635157, 3999.9400008999887, 4018.9196216076098, 4021.4369988201674, 4007.539132999684, 4043.9890027493125, 4055.878323650295, 4062.0657248832936, 4073.9592604074173, 4491.281394976853, 4513.255312873404, 4591.862244132682, 4593.471750748707, 4605.40129783126, 5431.7186781551845, 5461.754221060062, 5467.343918729778, 5472.0, 5495.670259784426, 1387.3132799264429, 1406.783132590302, 1412.813236881025, 1417.121384741467, 1417.3692706745605, 902.6524787956683, 913.3469569258012, 932.4964519159578, 956.0009789769707, 958.9664361747306, 5158.948410515847, 5179.19722443022, 5223.268742376071, 5253.317068781034, 5256.869772998747, 5548.250986116904, 5549.778008879681, 5554.472325129106, 5554.750036248379, 5562.415946325658, 5044.495550444926, 5199.0, 5212.566544200299, 5229.4770522948165, 5272.6836389816735, 2948.3366242595675, 2954.231899706092, 2958.556216567489, 2968.910932672023, 2975.1669532530927, 5475.589330800206, 5716.714164291769, 5728.198052272685, 5738.885222295614, 5742.598018138774, 5564.221009058735, 5607.074832652566, 5608.887822243532, 5640.435956404409, 5663.943360566424, 5640.448876558897, 5660.405657405995, 5664.85837854057, 5675.9499492594005, 5794.478496935296, 5325.973370133124, 5523.6685798852195, 5590.972045139911, 5594.3286805581965, 5601.215829783752, 5375.569954403716, 5383.973080134574, 5423.267858839006, 5435.483629055233, 5520.337559492726, 5665.773369065356, 5707.828765137053, 5711.514521265739, 5716.428357164416, 5721.456461636138, 3849.8845034649007, 3990.102226998902, 4000.979995100006, 4002.3796311571755, 4010.438538604539, 5479.739659878171, 5507.366652834815, 5512.84230311639, 5528.336599608073, 5570.972145139248, 5424.376196737426, 5426.561961080238, 5429.289773721265, 5441.564674825925, 5459.12653975362, 5192.1183743021475, 5490.584142977077, 5492.203630473479, 5493.807716729895, 5503.587230957774, 5123.0, 5155.690658560498, 5324.121519949165, 5338.172583249602, 5342.519173274424, 5487.176923461513, 5513.751881165277, 5521.365043020104, 5539.169124631177, 5574.052411090205, 5383.919241211307, 5409.540189083972, 5416.485433883775, 5436.728163591725, 5438.428964958623], "value": 4138.116649764949, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [715.7591271715087, 715.8675645005677, 745.2733584754865, 801.3909428834086, 808.4987307869122, 15344.156071416068, 15871.0, 16535.50393488194, 16559.751603725952, 16571.91714041428, 14646.194459304734, 15235.238238088079, 15317.310721017553, 15321.846781532182, 15330.540083797476, 663.9767608133716, 785.7171418289412, 792.5165648954134, 799.0810567846964, 800.4396922154486, 771.3135309574483, 801.1507801730155, 807.0718673525463, 808.2685169921231, 809.251442415766, 824.7855557555049, 824.9010118785724, 827.7599496146111, 828.3828547731918, 832.9708460203894, 689.2280645676824, 809.0655293136437, 819.8934138561979, 820.6430202861774, 821.2444551013052, 601.8435206846208, 606.4026933470528, 610.1183789424284, 610.5664977865721, 610.6702380714408, 15741.921290393475, 15763.448279310169, 15777.842221577752, 15789.368425262976, 15798.921005395014, 14563.417463301455, 15030.624234394118, 15057.849421505754, 15149.0, 15194.772078418833, 13137.27744974026, 13303.467861285633, 13319.26744029078, 13562.321883905865, 14008.719825603534, 4481.820727170909, 4530.3204519322035, 4562.703424277412, 4725.291206319045, 4731.219348807443, 80857.0, 81049.0, 81077.59461202715, 81083.0, 81341.59329203315, 11245.606403775828, 11270.54917803295, 11384.316940983403, 11445.0, 11787.351695656822, 21971.780282197295, 22054.558908821735, 22082.44793880166, 22096.447588810086, 22124.2256521021, 8289.088200297962, 8337.041240257327, 8493.193146651058, 8522.87215691765, 8683.696070637498, 4808.495108013608, 4972.0801651694555, 4992.5756310714, 5056.064628043824, 5060.367454068241, 3513.982430087833, 3633.5458067741533, 3638.3450978824067, 3670.0, 3670.9082272942856, 611.0, 628.7422156915643, 636.3000699230809, 637.0539748473514, 637.4772686397109, 558.4080874273284, 582.9067349224104, 732.1872721279376, 739.2496615934831, 753.5779963220505, 9310.767230819149, 9362.970073291932, 9421.152096311227, 9442.527873606292, 9514.476703781358, 551.5477308606984, 622.8785386849612, 644.8581312111422, 655.8622689235314, 665.544102289933, 4505.166544189336, 4606.976965115153, 4663.976680116578, 4680.204365257914, 4825.0, 72051.0, 100360.0, 125291.3735431317, 126527.73472265343, 128276.35861820632, 58363.708181458824, 59766.0, 59910.10134847981, 80724.0, 112058.43970780094, 86514.0, 89274.55362723145, 89546.10453895509, 90460.5476972624, 91358.08641913495, 9746.707598772047, 9869.555869986012, 10101.191904647758, 10102.191824654157, 10129.139023183112, 38165.0, 51934.740326298124, 52217.77302459831, 53449.198262025326, 54589.72705136449, 51196.232056518435, 55942.0, 74755.0, 75228.24771752213, 75336.0, 12908.677283067624, 12930.418131184308, 13211.603651890458, 13241.62418423807, 13831.100978436369, 14201.28993550339, 14428.134311941318, 15161.848381516043, 15382.0, 15716.764248536052, 13508.459661613819, 13995.790063149265, 14137.293135343398, 14396.640083997983, 14696.779548306999, 14095.365708543346, 14409.42362305496, 14519.854801452273, 15192.609377723902, 15289.617759555655, 13940.79088813689, 14186.858131418554, 14234.0, 14316.713665726835, 14331.641708957359, 11585.420728963687, 11671.533138674358, 11851.466683999068, 11908.880911190778, 12360.690982725504, 9955.850662240216, 10130.898691012995, 11237.775244495228, 11864.110191735826, 11865.169438139592], "value": 7576.839991932916, "unit": "score"}], "name": "dromaeo_css", "value": 7057.071707251485, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 104.0, 112.0, 110.0, 111.0, 111.0, 110.0, 110.0, 110.0, 111.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 131.0, 139.0, 185.0, 126.0, 170.0, 162.0, 127.0, 184.0, 127.0], "value": 150.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 160.0, 162.0, 161.0, 163.0, 163.0, 163.0, 162.0, 163.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 131.0, 83.0, 77.0, 76.0, 76.0, 100.0, 74.0], "value": 84.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 113.0, 87.0, 87.0, 85.0, 128.0, 86.0, 86.0, 130.0], "value": 97.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0, 146.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 56.0, 55.0, 58.0, 55.0, 56.0, 55.0, 56.0, 56.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 63.0, 63.0, 63.0, 62.0, 62.0, 62.0, 63.0], "value": 62.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 78.0, 79.0, 79.0, 80.0, 81.0, 83.0, 81.0, 111.0, 82.0], "value": 83.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 122.0, 129.0, 120.0, 132.0, 120.0, 126.0, 120.0, 143.0, 124.0], "value": 125.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 160.0, 160.0, 162.0, 161.0, 160.0, 161.0, 170.0, 158.0, 164.0], "value": 162.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 64.0, 64.0, 64.0, 65.0, 64.0, 62.0, 66.0], "value": 64.4, "unit": "score"}], "name": "kraken", "value": 1515.1000000000001, "alertThreshold": 2.0}]} 14:38:15 INFO - Return code: 0 14:38:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:38:15 INFO - # TBPL SUCCESS # 14:38:15 INFO - Running post-action listener: _resource_record_post_action 14:38:15 INFO - ##### 14:38:15 INFO - ##### Finished run-tests step (success) 14:38:15 INFO - ##### 14:38:15 INFO - Running post-run listener: _resource_record_post_run 14:38:15 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 550039552; Read time: 20; Write time: 456660 14:38:15 INFO - TinderboxPrint: CPU usage
13.2% 14:38:15 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 14:38:15 INFO - TinderboxPrint: I/O write bytes / time
550,039,552 / 456,660 14:38:15 INFO - TinderboxPrint: CPU idle
8,266.5 (86.8%) 14:38:15 INFO - TinderboxPrint: CPU user
1,207.5 (12.7%) 14:38:15 INFO - TinderboxPrint: Swap in / out
0 / 0 14:38:15 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 256229376; Read time: 0; Write time: 277640 14:38:15 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293810176; Read time: 20; Write time: 179020 14:38:16 INFO - Running post-run listener: _upload_blobber_files 14:38:16 INFO - Blob upload gear active. 14:38:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:38:16 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 14:38:16 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'] 14:38:16 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 14:38:16 INFO - (blobuploader) - INFO - Open directory for files ... 14:38:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:38:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:38:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:38:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:38:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:38:17 INFO - (blobuploader) - INFO - Done attempting. 14:38:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:38:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:38:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:38:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:38:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:38:18 INFO - (blobuploader) - INFO - Done attempting. 14:38:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:38:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:38:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:38:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:38:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:38:22 INFO - (blobuploader) - INFO - Done attempting. 14:38:22 INFO - (blobuploader) - INFO - Iteration through files over. 14:38:22 INFO - Return code: 0 14:38:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:38:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:38:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ffe7b2c7c0d01e745848f283f57e4ff05472a4544790d600b1263cc0c46359d37bf2401fdaf6e0867d34e7079283137f2441b5a47cbc7c4b663bb3659c7770a8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c1682bb58dd79d4e0b18ada6f3b9b04f282f699aad74dc08c946085c8bb585363cb95d7d40b55d95f7638bbdd4ef1ee1869e1edbbc7151b752012e24a9e0ec77", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b9cae44f93a8ab35fb81bbe08b3dedfe6d77a3a7359b80a02141385123a45d6578cad574fc8aa7dbe299f632e0ea8d2f42f1e57a9a83a578b44ac8f5d67cc1a7"} 14:38:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:38:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:38:22 INFO - Contents: 14:38:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ffe7b2c7c0d01e745848f283f57e4ff05472a4544790d600b1263cc0c46359d37bf2401fdaf6e0867d34e7079283137f2441b5a47cbc7c4b663bb3659c7770a8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c1682bb58dd79d4e0b18ada6f3b9b04f282f699aad74dc08c946085c8bb585363cb95d7d40b55d95f7638bbdd4ef1ee1869e1edbbc7151b752012e24a9e0ec77", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b9cae44f93a8ab35fb81bbe08b3dedfe6d77a3a7359b80a02141385123a45d6578cad574fc8aa7dbe299f632e0ea8d2f42f1e57a9a83a578b44ac8f5d67cc1a7"} 14:38:22 INFO - Running post-run listener: copy_logs_to_upload_dir 14:38:22 INFO - Copying logs to upload dir... 14:38:22 INFO - mkdir: /builds/slave/test/build/upload/logs 14:38:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.802536 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-06-17 14:38:22.484337) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-17 14:38:22.488019) ========= 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=0333a256a5e4f052382dd180000001b1-1466196144.947426-438012893 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ffe7b2c7c0d01e745848f283f57e4ff05472a4544790d600b1263cc0c46359d37bf2401fdaf6e0867d34e7079283137f2441b5a47cbc7c4b663bb3659c7770a8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c1682bb58dd79d4e0b18ada6f3b9b04f282f699aad74dc08c946085c8bb585363cb95d7d40b55d95f7638bbdd4ef1ee1869e1edbbc7151b752012e24a9e0ec77", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b9cae44f93a8ab35fb81bbe08b3dedfe6d77a3a7359b80a02141385123a45d6578cad574fc8aa7dbe299f632e0ea8d2f42f1e57a9a83a578b44ac8f5d67cc1a7"} build_url:https://queue.taskcluster.net/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011278 build_url: 'https://queue.taskcluster.net/v1/task/enkyn-Q3Tli1Y1mMgF3WhQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ffe7b2c7c0d01e745848f283f57e4ff05472a4544790d600b1263cc0c46359d37bf2401fdaf6e0867d34e7079283137f2441b5a47cbc7c4b663bb3659c7770a8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c1682bb58dd79d4e0b18ada6f3b9b04f282f699aad74dc08c946085c8bb585363cb95d7d40b55d95f7638bbdd4ef1ee1869e1edbbc7151b752012e24a9e0ec77", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b9cae44f93a8ab35fb81bbe08b3dedfe6d77a3a7359b80a02141385123a45d6578cad574fc8aa7dbe299f632e0ea8d2f42f1e57a9a83a578b44ac8f5d67cc1a7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-17 14:38:22.513037) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 14:38:22.513368) ========= 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=0333a256a5e4f052382dd180000001b1-1466196144.947426-438012893 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004475 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 14:38:22.596215) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-17 14:38:22.596519) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-17 14:38:22.596786) ========= ========= Total master_lag: 0.18 =========