builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-020 starttime: 1483385526.64 results: success (0) revision: c91249f41e3766274131a84f9157a4d9d9949520 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-02 11:32:06.644613) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-02 11:32:06.645075) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-02 11:32:06.645381) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-02 11:32:06.660444) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 11:32:06.660823) ========= 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=af724c981e2a0f424dbabf99000001e7-1483375803.390749-978377419 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-02 11:32:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.2M=0s 2017-01-02 11:32:07 (42.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.111206 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 11:32:06.787178) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 11:32:06.787691) ========= 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=af724c981e2a0f424dbabf99000001e7-1483375803.390749-978377419 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016801 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 11:32:06.838355) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-02 11:32:06.838703) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c91249f41e3766274131a84f9157a4d9d9949520 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev c91249f41e3766274131a84f9157a4d9d9949520 --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=af724c981e2a0f424dbabf99000001e7-1483375803.390749-978377419 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-02 11:32:07,542 truncating revision to first 12 chars 2017-01-02 11:32:07,542 Setting DEBUG logging. 2017-01-02 11:32:07,542 attempt 1/10 2017-01-02 11:32:07,542 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c91249f41e37?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-02 11:32:08,559 unpacking tar archive at: mozilla-central-c91249f41e37/testing/mozharness/ program finished with exit code 0 elapsedTime=1.339724 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-02 11:32:08.193115) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-02 11:32:08.193444) ========= script_repo_revision: c91249f41e3766274131a84f9157a4d9d9949520 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-02 11:32:08.193833) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-02 11:32:08.194163) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-02 11:32:08.204484) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-01-02 11:32:08.204786) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=af724c981e2a0f424dbabf99000001e7-1483375803.390749-978377419 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:32:08 INFO - MultiFileLogger online at 20170102 11:32:08 in /builds/slave/test 11:32:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 11:32:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:32:08 INFO - {'append_to_log': False, 11:32:08 INFO - 'base_work_dir': '/builds/slave/test', 11:32:08 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 11:32:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:32:08 INFO - 'branch': 'Firefox-Non-PGO', 11:32:08 INFO - 'buildbot_json_path': 'buildprops.json', 11:32:08 INFO - 'config_files': ('talos/linux_config.py',), 11:32:08 INFO - 'default_actions': ('clobber', 11:32:08 INFO - 'read-buildbot-config', 11:32:09 INFO - 'download-and-extract', 11:32:09 INFO - 'populate-webroot', 11:32:09 INFO - 'create-virtualenv', 11:32:09 INFO - 'install', 11:32:09 INFO - 'run-tests'), 11:32:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:32:09 INFO - 'download_minidump_stackwalk': True, 11:32:09 INFO - 'download_symbols': 'ondemand', 11:32:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:32:09 INFO - 'tooltool.py': '/tools/tooltool.py', 11:32:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:32:09 INFO - '/tools/misc-python/virtualenv.py')}, 11:32:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:32:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:32:09 INFO - 'installer_path': 'installer.exe', 11:32:09 INFO - 'log_level': 'info', 11:32:09 INFO - 'log_name': 'talos', 11:32:09 INFO - 'log_to_console': True, 11:32:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:32:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:32:09 INFO - 'opt_config_files': (), 11:32:09 INFO - 'pip_index': False, 11:32:09 INFO - 'sps_profile': False, 11:32:09 INFO - 'sps_profile_interval': 0, 11:32:09 INFO - 'suite': 'dromaeojs', 11:32:09 INFO - 'system_bits': '32', 11:32:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:32:09 INFO - 'title': 'talos-linux64-ix-020', 11:32:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:32:09 INFO - 'use_talos_json': True, 11:32:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:32:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:32:09 INFO - 'work_dir': 'build'} 11:32:09 INFO - [mozharness: 2017-01-02 19:32:09.002513Z] Running clobber step. 11:32:09 INFO - Running pre-action listener: _resource_record_pre_action 11:32:09 INFO - Running main action method: clobber 11:32:09 INFO - rmtree: /builds/slave/test/build 11:32:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:32:09 INFO - Running post-action listener: _resource_record_post_action 11:32:09 INFO - [mozharness: 2017-01-02 19:32:09.987122Z] Finished clobber step (success) 11:32:09 INFO - [mozharness: 2017-01-02 19:32:09.987221Z] Running read-buildbot-config step. 11:32:09 INFO - Running pre-action listener: _resource_record_pre_action 11:32:09 INFO - Running main action method: read_buildbot_config 11:32:09 INFO - Using buildbot properties: 11:32:09 INFO - { 11:32:09 INFO - "project": "", 11:32:09 INFO - "product": "firefox", 11:32:09 INFO - "who": "philringnalda@gmail.com", 11:32:09 INFO - "installer_path": "public/build/target.tar.bz2", 11:32:09 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 11:32:09 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 11:32:09 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 11:32:09 INFO - "stage_platform": "linux64", 11:32:09 INFO - "basedir": "/builds/slave/test", 11:32:09 INFO - "buildnumber": 895, 11:32:09 INFO - "platform": "ubuntu64_hw", 11:32:09 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:32:09 INFO - "slavebuilddir": "test", 11:32:09 INFO - "taskId": "ObdcDln9TR2Xte8bJDE7oA", 11:32:09 INFO - "branch": "mozilla-central", 11:32:09 INFO - "script_repo_revision": "production", 11:32:09 INFO - "revision": "c91249f41e3766274131a84f9157a4d9d9949520", 11:32:09 INFO - "slavename": "talos-linux64-ix-020", 11:32:09 INFO - "repo_path": "mozilla-central" 11:32:09 INFO - } 11:32:09 INFO - Finding installer, test and symbols from parent task. 11:32:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ObdcDln9TR2Xte8bJDE7oA'}, attempt #1 11:32:10 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ObdcDln9TR2Xte8bJDE7oA'}, attempt #1 11:32:10 INFO - Task dependencies: UC_N8bMsR0CJ34QVha7V_w 11:32:10 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UC_N8bMsR0CJ34QVha7V_w'}, attempt #1 11:32:11 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/UC_N8bMsR0CJ34QVha7V_w/artifacts/public/build/target.tar.bz2 11:32:11 INFO - Set test_url: https://queue.taskcluster.net/v1/task/UC_N8bMsR0CJ34QVha7V_w/artifacts/public/build/test_packages.json 11:32:11 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/UC_N8bMsR0CJ34QVha7V_w/artifacts/public/build/target.crashreporter-symbols.zip 11:32:11 INFO - Running post-action listener: _resource_record_post_action 11:32:11 INFO - [mozharness: 2017-01-02 19:32:11.370418Z] Finished read-buildbot-config step (success) 11:32:11 INFO - [mozharness: 2017-01-02 19:32:11.370635Z] Running download-and-extract step. 11:32:11 INFO - Running pre-action listener: _resource_record_pre_action 11:32:11 INFO - Running main action method: download_and_extract 11:32:11 INFO - mkdir: /builds/slave/test/build/tests 11:32: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:11 INFO - trying https://queue.taskcluster.net/v1/task/UC_N8bMsR0CJ34QVha7V_w/artifacts/public/build/target.test_packages.json 11:32:11 INFO - Downloading https://queue.taskcluster.net/v1/task/UC_N8bMsR0CJ34QVha7V_w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:32:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UC_N8bMsR0CJ34QVha7V_w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:32:11 INFO - Downloaded 896 bytes. 11:32:11 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:32:11 INFO - Using the following test package requirements: 11:32:11 INFO - {u'common': [u'target.common.tests.zip'], 11:32:11 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:32:11 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:32:11 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:32:11 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:32:11 INFO - u'mozbase': [u'target.common.tests.zip'], 11:32:11 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:32:11 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:32:11 INFO - u'web-platform': [u'target.common.tests.zip', 11:32:11 INFO - u'target.web-platform.tests.zip'], 11:32:11 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:32:11 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 11:32:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UC_N8bMsR0CJ34QVha7V_w/artifacts/public/build/target.common.tests.zip 11:32:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UC_N8bMsR0CJ34QVha7V_w/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:32:11 INFO - Fetch https://queue.taskcluster.net/v1/task/UC_N8bMsR0CJ34QVha7V_w/artifacts/public/build/target.common.tests.zip into memory 11:32:12 INFO - Expected file size: 20246928 11:32:12 INFO - Obtained file size: 20246928 11:32:16 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 11:32:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UC_N8bMsR0CJ34QVha7V_w/artifacts/public/build/target.common.tests.zip 11:32:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UC_N8bMsR0CJ34QVha7V_w/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:32:16 INFO - Fetch https://queue.taskcluster.net/v1/task/UC_N8bMsR0CJ34QVha7V_w/artifacts/public/build/target.common.tests.zip into memory 11:32:17 INFO - Expected file size: 20246928 11:32:17 INFO - Obtained file size: 20246928 11:32:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UC_N8bMsR0CJ34QVha7V_w/artifacts/public/build/target.talos.tests.zip 11:32:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UC_N8bMsR0CJ34QVha7V_w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:32:21 INFO - Fetch https://queue.taskcluster.net/v1/task/UC_N8bMsR0CJ34QVha7V_w/artifacts/public/build/target.talos.tests.zip into memory 11:32:22 INFO - Expected file size: 14409776 11:32:22 INFO - Obtained file size: 14409776 11:32:23 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:23 INFO - trying https://queue.taskcluster.net/v1/task/UC_N8bMsR0CJ34QVha7V_w/artifacts/public/build/target.tar.bz2 11:32:23 INFO - Downloading https://queue.taskcluster.net/v1/task/UC_N8bMsR0CJ34QVha7V_w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:32:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UC_N8bMsR0CJ34QVha7V_w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:32:24 INFO - Downloaded 55799813 bytes. 11:32:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UC_N8bMsR0CJ34QVha7V_w/artifacts/public/build/target.tar.bz2 11:32:24 INFO - mkdir: /builds/slave/test/properties 11:32:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:32:24 INFO - Writing to file /builds/slave/test/properties/build_url 11:32:24 INFO - Contents: 11:32:24 INFO - build_url:https://queue.taskcluster.net/v1/task/UC_N8bMsR0CJ34QVha7V_w/artifacts/public/build/target.tar.bz2 11:32:24 INFO - Running post-action listener: _resource_record_post_action 11:32:24 INFO - Running post-action listener: set_extra_try_arguments 11:32:24 INFO - [mozharness: 2017-01-02 19:32:24.120382Z] Finished download-and-extract step (success) 11:32:24 INFO - [mozharness: 2017-01-02 19:32:24.120479Z] Running populate-webroot step. 11:32:24 INFO - Running pre-action listener: _resource_record_pre_action 11:32:24 INFO - Running main action method: populate_webroot 11:32:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:32:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:32:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:32:24 INFO - '--tppagecycles', 11:32:24 INFO - '7'], 11:32:24 INFO - 'tests': ['tsvgm']}}, 11:32:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:32:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:32:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:32:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:32:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:32:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:32:24 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 11:32:24 INFO - 'talos_options': ['--disable-e10s'], 11:32:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:32:24 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:32:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:32:24 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 11:32:24 INFO - 'talos_options': ['--disable-e10s'], 11:32:24 INFO - 'tests': ['damp', 'tps']}, 11:32:24 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:32:24 INFO - 'tests': ['damp', 'tps']}, 11:32:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:32:24 INFO - 'tests': ['dromaeo_dom']}, 11:32:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:32:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:32:24 INFO - 'tests': ['basic_compositor_video']}, 11:32:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:32:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:32:24 INFO - 'tests': ['a11yr', 11:32:24 INFO - 'ts_paint', 11:32:24 INFO - 'tpaint', 11:32:24 INFO - 'sessionrestore', 11:32:24 INFO - 'sessionrestore_no_auto_restore', 11:32:24 INFO - 'tabpaint']}, 11:32:24 INFO - 'other-e10s': {'tests': ['a11yr', 11:32:24 INFO - 'ts_paint', 11:32:24 INFO - 'tpaint', 11:32:24 INFO - 'sessionrestore', 11:32:24 INFO - 'sessionrestore_no_auto_restore', 11:32:24 INFO - 'tabpaint']}, 11:32:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:32:24 INFO - 'ts_paint', 11:32:24 INFO - 'tpaint', 11:32:24 INFO - 'sessionrestore', 11:32:24 INFO - 'sessionrestore_no_auto_restore', 11:32:24 INFO - 'tabpaint']}, 11:32:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:32:24 INFO - 'ts_paint', 11:32:24 INFO - 'tpaint', 11:32:24 INFO - 'sessionrestore', 11:32:24 INFO - 'sessionrestore_no_auto_restore', 11:32:24 INFO - 'tabpaint']}, 11:32:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:32:24 INFO - 'tests': ['a11yr', 11:32:24 INFO - 'ts_paint', 11:32:24 INFO - 'tpaint', 11:32:24 INFO - 'sessionrestore', 11:32:24 INFO - 'sessionrestore_no_auto_restore', 11:32:24 INFO - 'tabpaint']}, 11:32:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:32:24 INFO - 'tests': ['a11yr', 11:32:24 INFO - 'ts_paint', 11:32:24 INFO - 'tpaint', 11:32:24 INFO - 'sessionrestore', 11:32:24 INFO - 'sessionrestore_no_auto_restore', 11:32:24 INFO - 'tabpaint']}, 11:32:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:32:24 INFO - 'tests': ['tsvgx', 11:32:24 INFO - 'tsvgr_opacity', 11:32:24 INFO - 'tart', 11:32:24 INFO - 'tscrollx', 11:32:24 INFO - 'cart', 11:32:24 INFO - 'tsvg_static']}, 11:32:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:32:24 INFO - 'tsvgr_opacity', 11:32:24 INFO - 'tart', 11:32:24 INFO - 'tscrollx', 11:32:24 INFO - 'cart', 11:32:24 INFO - 'tsvg_static']}, 11:32:24 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 11:32:24 INFO - 'talos_options': ['--disable-e10s'], 11:32:24 INFO - 'tests': ['tp5o']}, 11:32:24 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:32:24 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 11:32:24 INFO - 'talos_options': ['--disable-e10s', 11:32:24 INFO - '--xperf_path', 11:32:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:32:24 INFO - 'tests': ['tp5n']}, 11:32:24 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:32:24 INFO - 'talos_options': ['--xperf_path', 11:32:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:32:24 INFO - 'tests': ['tp5n']}}, 11:32:24 INFO - 'talos.zip': {'path': '', 11:32:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:32:24 INFO - Running post-action listener: _resource_record_post_action 11:32:24 INFO - [mozharness: 2017-01-02 19:32:24.133564Z] Finished populate-webroot step (success) 11:32:24 INFO - [mozharness: 2017-01-02 19:32:24.133657Z] Running create-virtualenv step. 11:32:24 INFO - Running pre-action listener: _resource_record_pre_action 11:32:24 INFO - Running main action method: create_virtualenv 11:32:24 INFO - Creating virtualenv /builds/slave/test/build/venv 11:32:24 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 11:32:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:32:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:32:24 INFO - Using real prefix '/usr' 11:32:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:32:24 INFO - Installing distribute.............................................................................................................................................................................................done. 11:32:26 INFO - Installing pip.................done. 11:32:26 INFO - Return code: 0 11:32:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:32:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:32:26 INFO - Reading from file tmpfile_stdout 11:32:26 INFO - Output received: 11:32:26 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 11:32:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:32:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1133630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11bc850>, '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 0x11316d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1131b60>, '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': 'af724c981e2a0f424dbabf99000001e7-1483375803.390749-978377419', '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 11:32:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:32:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:32:26 INFO - Using env: {'DISPLAY': ':0', 11:32:26 INFO - 'HOME': '/home/cltbld', 11:32:26 INFO - 'LANG': 'en_US.UTF-8', 11:32:26 INFO - 'LANGUAGE': 'en_US:en', 11:32:26 INFO - 'LOGNAME': 'cltbld', 11:32:26 INFO - 'MAIL': '/var/mail/cltbld', 11:32:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:26 INFO - 'MOZ_NO_REMOTE': '1', 11:32:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:26 INFO - 'NO_EM_RESTART': '1', 11:32:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:26 INFO - 'PWD': '/builds/slave/test', 11:32:26 INFO - 'SHELL': '/bin/bash', 11:32:26 INFO - 'SHLVL': '1', 11:32:26 INFO - 'TERM': 'linux', 11:32:26 INFO - 'TMOUT': '86400', 11:32:26 INFO - 'USER': 'cltbld', 11:32:26 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1483375803.390749-978377419', 11:32:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:26 INFO - '_': '/tools/buildbot/bin/python'} 11:32:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:27 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 11:32:27 INFO - Cleaning up... 11:32:27 INFO - Return code: 0 11:32:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:32: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:27 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 0xdc11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1133630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11bc850>, '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 0x11316d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1131b60>, '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': 'af724c981e2a0f424dbabf99000001e7-1483375803.390749-978377419', '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 11:32:27 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 11:32:27 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 11:32:27 INFO - Using env: {'DISPLAY': ':0', 11:32:27 INFO - 'HOME': '/home/cltbld', 11:32:27 INFO - 'LANG': 'en_US.UTF-8', 11:32:27 INFO - 'LANGUAGE': 'en_US:en', 11:32:27 INFO - 'LOGNAME': 'cltbld', 11:32:27 INFO - 'MAIL': '/var/mail/cltbld', 11:32:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:27 INFO - 'MOZ_NO_REMOTE': '1', 11:32:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:27 INFO - 'NO_EM_RESTART': '1', 11:32:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:27 INFO - 'PWD': '/builds/slave/test', 11:32:27 INFO - 'SHELL': '/bin/bash', 11:32:27 INFO - 'SHLVL': '1', 11:32:27 INFO - 'TERM': 'linux', 11:32:27 INFO - 'TMOUT': '86400', 11:32:27 INFO - 'USER': 'cltbld', 11:32:27 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1483375803.390749-978377419', 11:32:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:27 INFO - '_': '/tools/buildbot/bin/python'} 11:32:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:27 INFO - Downloading/unpacking psutil>=3.1.1 11:32:27 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 11:32:27 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 11:32:27 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 11:32:27 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 11:32:27 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 11:32:27 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 11:32:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:32:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:32:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:32:29 INFO - Installing collected packages: psutil 11:32:29 INFO - Running setup.py install for psutil 11:32:29 INFO - building 'psutil._psutil_linux' extension 11:32:29 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 11:32:29 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 11:32:29 INFO - building 'psutil._psutil_posix' extension 11:32:29 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 11:32:29 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 11:32:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:32:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:32:29 INFO - Successfully installed psutil 11:32:29 INFO - Cleaning up... 11:32:30 INFO - Return code: 0 11:32:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:32:30 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:30 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:30 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 0xdc11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1133630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11bc850>, '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 0x11316d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1131b60>, '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': 'af724c981e2a0f424dbabf99000001e7-1483375803.390749-978377419', '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 11:32:30 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 11:32:30 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 11:32:30 INFO - Using env: {'DISPLAY': ':0', 11:32:30 INFO - 'HOME': '/home/cltbld', 11:32:30 INFO - 'LANG': 'en_US.UTF-8', 11:32:30 INFO - 'LANGUAGE': 'en_US:en', 11:32:30 INFO - 'LOGNAME': 'cltbld', 11:32:30 INFO - 'MAIL': '/var/mail/cltbld', 11:32:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:30 INFO - 'MOZ_NO_REMOTE': '1', 11:32:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:30 INFO - 'NO_EM_RESTART': '1', 11:32:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:30 INFO - 'PWD': '/builds/slave/test', 11:32:30 INFO - 'SHELL': '/bin/bash', 11:32:30 INFO - 'SHLVL': '1', 11:32:30 INFO - 'TERM': 'linux', 11:32:30 INFO - 'TMOUT': '86400', 11:32:30 INFO - 'USER': 'cltbld', 11:32:30 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1483375803.390749-978377419', 11:32:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:30 INFO - '_': '/tools/buildbot/bin/python'} 11:32:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:32:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:32:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:32:32 INFO - Installing collected packages: mozsystemmonitor 11:32:32 INFO - Running setup.py install for mozsystemmonitor 11:32:32 INFO - Successfully installed mozsystemmonitor 11:32:32 INFO - Cleaning up... 11:32:32 INFO - Return code: 0 11:32:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:32:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1133630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11bc850>, '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 0x11316d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1131b60>, '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': 'af724c981e2a0f424dbabf99000001e7-1483375803.390749-978377419', '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 11:32:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:32:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:32:32 INFO - Using env: {'DISPLAY': ':0', 11:32:32 INFO - 'HOME': '/home/cltbld', 11:32:32 INFO - 'LANG': 'en_US.UTF-8', 11:32:32 INFO - 'LANGUAGE': 'en_US:en', 11:32:32 INFO - 'LOGNAME': 'cltbld', 11:32:32 INFO - 'MAIL': '/var/mail/cltbld', 11:32:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:32 INFO - 'MOZ_NO_REMOTE': '1', 11:32:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:32 INFO - 'NO_EM_RESTART': '1', 11:32:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:32 INFO - 'PWD': '/builds/slave/test', 11:32:32 INFO - 'SHELL': '/bin/bash', 11:32:32 INFO - 'SHLVL': '1', 11:32:32 INFO - 'TERM': 'linux', 11:32:32 INFO - 'TMOUT': '86400', 11:32:32 INFO - 'USER': 'cltbld', 11:32:32 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1483375803.390749-978377419', 11:32:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:32 INFO - '_': '/tools/buildbot/bin/python'} 11:32:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:32 INFO - Downloading/unpacking jsonschema==2.5.1 11:32:32 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 11:32:32 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 11:32:32 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 11:32:32 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 11:32:32 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 11:32:32 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 11:32:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:32:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:32:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:34 INFO - Downloading functools32-3.2.3-2.tar.gz 11:32:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:32:34 INFO - warning: no files found matching '*.txt' 11:32:34 INFO - no previously-included directories found matching 'build' 11:32:34 INFO - no previously-included directories found matching 'dist' 11:32:34 INFO - no previously-included directories found matching '.git*' 11:32:34 INFO - Installing collected packages: jsonschema, functools32 11:32:34 INFO - Running setup.py install for functools32 11:32:35 INFO - warning: no files found matching '*.txt' 11:32:35 INFO - no previously-included directories found matching 'build' 11:32:35 INFO - no previously-included directories found matching 'dist' 11:32:35 INFO - no previously-included directories found matching '.git*' 11:32:35 INFO - Successfully installed jsonschema functools32 11:32:35 INFO - Cleaning up... 11:32:35 INFO - Return code: 0 11:32:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:32:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdc11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1133630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11bc850>, '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 0x11316d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1131b60>, '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': 'af724c981e2a0f424dbabf99000001e7-1483375803.390749-978377419', '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 11:32:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:32:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:32:35 INFO - Using env: {'DISPLAY': ':0', 11:32:35 INFO - 'HOME': '/home/cltbld', 11:32:35 INFO - 'LANG': 'en_US.UTF-8', 11:32:35 INFO - 'LANGUAGE': 'en_US:en', 11:32:35 INFO - 'LOGNAME': 'cltbld', 11:32:35 INFO - 'MAIL': '/var/mail/cltbld', 11:32:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:35 INFO - 'MOZ_NO_REMOTE': '1', 11:32:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:35 INFO - 'NO_EM_RESTART': '1', 11:32:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:35 INFO - 'PWD': '/builds/slave/test', 11:32:35 INFO - 'SHELL': '/bin/bash', 11:32:35 INFO - 'SHLVL': '1', 11:32:35 INFO - 'TERM': 'linux', 11:32:35 INFO - 'TMOUT': '86400', 11:32:35 INFO - 'USER': 'cltbld', 11:32:35 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1483375803.390749-978377419', 11:32:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:35 INFO - '_': '/tools/buildbot/bin/python'} 11:32:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:32:35 INFO - Cleaning up... 11:32:35 INFO - Return code: 0 11:32:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:32:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xdc11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1133630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11bc850>, '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 0x11316d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1131b60>, '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': 'af724c981e2a0f424dbabf99000001e7-1483375803.390749-978377419', '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 11:32:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:32:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:32:35 INFO - Using env: {'DISPLAY': ':0', 11:32:35 INFO - 'HOME': '/home/cltbld', 11:32:35 INFO - 'LANG': 'en_US.UTF-8', 11:32:35 INFO - 'LANGUAGE': 'en_US:en', 11:32:35 INFO - 'LOGNAME': 'cltbld', 11:32:35 INFO - 'MAIL': '/var/mail/cltbld', 11:32:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:35 INFO - 'MOZ_NO_REMOTE': '1', 11:32:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:35 INFO - 'NO_EM_RESTART': '1', 11:32:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:35 INFO - 'PWD': '/builds/slave/test', 11:32:35 INFO - 'SHELL': '/bin/bash', 11:32:35 INFO - 'SHLVL': '1', 11:32:35 INFO - 'TERM': 'linux', 11:32:35 INFO - 'TMOUT': '86400', 11:32:35 INFO - 'USER': 'cltbld', 11:32:35 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1483375803.390749-978377419', 11:32:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:35 INFO - '_': '/tools/buildbot/bin/python'} 11:32:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:35 INFO - Downloading/unpacking blobuploader==1.2.4 11:32:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:37 INFO - Downloading blobuploader-1.2.4.tar.gz 11:32:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:32:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:32:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:32:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:38 INFO - Downloading docopt-0.6.1.tar.gz 11:32:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:32:38 INFO - Installing collected packages: blobuploader, requests, docopt 11:32:38 INFO - Running setup.py install for blobuploader 11:32:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:32:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:32:38 INFO - Running setup.py install for requests 11:32:38 INFO - Running setup.py install for docopt 11:32:38 INFO - Successfully installed blobuploader requests docopt 11:32:38 INFO - Cleaning up... 11:32:38 INFO - Return code: 0 11:32:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:32:38 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:38 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:38 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 0xdc11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1133630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11bc850>, '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 0x11316d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1131b60>, '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': 'af724c981e2a0f424dbabf99000001e7-1483375803.390749-978377419', '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 11:32:38 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 11:32:38 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 11:32:38 INFO - Using env: {'DISPLAY': ':0', 11:32:38 INFO - 'HOME': '/home/cltbld', 11:32:38 INFO - 'LANG': 'en_US.UTF-8', 11:32:38 INFO - 'LANGUAGE': 'en_US:en', 11:32:38 INFO - 'LOGNAME': 'cltbld', 11:32:38 INFO - 'MAIL': '/var/mail/cltbld', 11:32:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:38 INFO - 'MOZ_NO_REMOTE': '1', 11:32:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:38 INFO - 'NO_EM_RESTART': '1', 11:32:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:38 INFO - 'PWD': '/builds/slave/test', 11:32:38 INFO - 'SHELL': '/bin/bash', 11:32:38 INFO - 'SHLVL': '1', 11:32:38 INFO - 'TERM': 'linux', 11:32:38 INFO - 'TMOUT': '86400', 11:32:38 INFO - 'USER': 'cltbld', 11:32:38 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1483375803.390749-978377419', 11:32:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:38 INFO - '_': '/tools/buildbot/bin/python'} 11:32:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:32:39 INFO - Running setup.py (path:/tmp/pip-JGx9k5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:32:39 INFO - Running setup.py (path:/tmp/pip-D4PC1u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:32:39 INFO - Running setup.py (path:/tmp/pip-W0h2aW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:32:39 INFO - Running setup.py (path:/tmp/pip-EWGWaj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:32:39 INFO - Running setup.py (path:/tmp/pip-s96eE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:32:39 INFO - Running setup.py (path:/tmp/pip-XBH2o5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:32:39 INFO - Running setup.py (path:/tmp/pip-Tnd3xV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:32:39 INFO - Running setup.py (path:/tmp/pip-Q10lYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:32:39 INFO - Running setup.py (path:/tmp/pip-deN0MH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:32:39 INFO - Running setup.py (path:/tmp/pip-45fjeW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:32:39 INFO - Running setup.py (path:/tmp/pip-yzgZMM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:32:40 INFO - Running setup.py (path:/tmp/pip-9_gLQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:32:40 INFO - Running setup.py (path:/tmp/pip-x4YSaz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:32:40 INFO - Running setup.py (path:/tmp/pip-IoCWC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:32:40 INFO - Running setup.py (path:/tmp/pip-vzyuSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:32:40 INFO - Running setup.py (path:/tmp/pip-QumIuW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:32:40 INFO - Running setup.py (path:/tmp/pip-Iq0E4d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:32:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:32:40 INFO - Running setup.py install for manifestparser 11:32:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:32:40 INFO - Running setup.py install for mozcrash 11:32:40 INFO - Running setup.py install for mozdebug 11:32:40 INFO - Running setup.py install for mozdevice 11:32:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:32:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:32:40 INFO - Running setup.py install for mozfile 11:32:40 INFO - Running setup.py install for mozhttpd 11:32:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:32:41 INFO - Running setup.py install for mozinfo 11:32:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:32:41 INFO - Running setup.py install for mozInstall 11:32:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:32:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:32:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:32:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:32:41 INFO - Running setup.py install for mozleak 11:32:41 INFO - Running setup.py install for mozlog 11:32:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:32:41 INFO - Running setup.py install for moznetwork 11:32:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:32:41 INFO - Running setup.py install for mozprocess 11:32:41 INFO - Running setup.py install for mozprofile 11:32:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:32:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:32:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:32:41 INFO - Running setup.py install for mozrunner 11:32:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:32:41 INFO - Running setup.py install for mozscreenshot 11:32:42 INFO - Running setup.py install for moztest 11:32:42 INFO - Running setup.py install for mozversion 11:32:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:32:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:32:42 INFO - Cleaning up... 11:32:42 INFO - Return code: 0 11:32:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:32:42 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:42 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:42 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 0xdc11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1133630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11bc850>, '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 0x11316d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1131b60>, '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': 'af724c981e2a0f424dbabf99000001e7-1483375803.390749-978377419', '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 11:32:42 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 11:32:42 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 11:32:42 INFO - Using env: {'DISPLAY': ':0', 11:32:42 INFO - 'HOME': '/home/cltbld', 11:32:42 INFO - 'LANG': 'en_US.UTF-8', 11:32:42 INFO - 'LANGUAGE': 'en_US:en', 11:32:42 INFO - 'LOGNAME': 'cltbld', 11:32:42 INFO - 'MAIL': '/var/mail/cltbld', 11:32:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:42 INFO - 'MOZ_NO_REMOTE': '1', 11:32:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:42 INFO - 'NO_EM_RESTART': '1', 11:32:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:42 INFO - 'PWD': '/builds/slave/test', 11:32:42 INFO - 'SHELL': '/bin/bash', 11:32:42 INFO - 'SHLVL': '1', 11:32:42 INFO - 'TERM': 'linux', 11:32:42 INFO - 'TMOUT': '86400', 11:32:42 INFO - 'USER': 'cltbld', 11:32:42 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1483375803.390749-978377419', 11:32:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:42 INFO - '_': '/tools/buildbot/bin/python'} 11:32:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:32:42 INFO - Running setup.py (path:/tmp/pip-XSh7vj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:32:42 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)) 11:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:32:42 INFO - Running setup.py (path:/tmp/pip-QIS3RJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:32:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 11:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:32:42 INFO - Running setup.py (path:/tmp/pip-inwZQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:32:42 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)) 11:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:32:42 INFO - Running setup.py (path:/tmp/pip-T1q3gz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:32:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 11:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:32:42 INFO - Running setup.py (path:/tmp/pip-yGUobP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:32:42 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)) 11:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:32:42 INFO - Running setup.py (path:/tmp/pip-Jye0yJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:32:42 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)) 11:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:32:42 INFO - Running setup.py (path:/tmp/pip-FP8dMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:32:42 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)) 11:32:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:32:42 INFO - Running setup.py (path:/tmp/pip-238_sD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:32:43 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)) 11:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:32:43 INFO - Running setup.py (path:/tmp/pip-GAUQsH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:32:43 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)) 11:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:32:43 INFO - Running setup.py (path:/tmp/pip-KCrWa0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:32:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 11:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:32:43 INFO - Running setup.py (path:/tmp/pip-MMvyCD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:32:43 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)) 11:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:32:43 INFO - Running setup.py (path:/tmp/pip-Y_f91Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:32:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 11:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:32:43 INFO - Running setup.py (path:/tmp/pip-7acpI3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:32:43 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)) 11:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:32:43 INFO - Running setup.py (path:/tmp/pip-p5VH4Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:32:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 11:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:32:43 INFO - Running setup.py (path:/tmp/pip-5Kok6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:32:43 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)) 11:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:32:43 INFO - Running setup.py (path:/tmp/pip-wK9FNd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:32:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 11:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:32:43 INFO - Running setup.py (path:/tmp/pip-YNDPSb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:32:43 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)) 11:32:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:32:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:32:43 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)) 11:32:43 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:32:43 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:32:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:32:43 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 11:32:43 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 11:32:43 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 11:32:43 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 11:32:43 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 11:32:43 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 11:32:45 INFO - Downloading blessings-1.6.tar.gz 11:32:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:32:45 INFO - Installing collected packages: blessings 11:32:45 INFO - Running setup.py install for blessings 11:32:45 INFO - Successfully installed blessings 11:32:45 INFO - Cleaning up... 11:32:45 INFO - Return code: 0 11:32:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:32:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:32:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:32:46 INFO - Reading from file tmpfile_stdout 11:32:46 INFO - Current package versions: 11:32:46 INFO - argparse == 1.2.1 11:32:46 INFO - blessings == 1.6 11:32:46 INFO - blobuploader == 1.2.4 11:32:46 INFO - docopt == 0.6.1 11:32:46 INFO - functools32 == 3.2.3-2 11:32:46 INFO - jsonschema == 2.5.1 11:32:46 INFO - manifestparser == 1.1 11:32:46 INFO - mozInstall == 1.12 11:32:46 INFO - mozcrash == 1.0 11:32:46 INFO - mozdebug == 0.1 11:32:46 INFO - mozdevice == 0.49 11:32:46 INFO - mozfile == 1.2 11:32:46 INFO - mozhttpd == 0.7 11:32:46 INFO - mozinfo == 0.9 11:32:46 INFO - mozleak == 0.1 11:32:46 INFO - mozlog == 3.4 11:32:46 INFO - moznetwork == 0.27 11:32:46 INFO - mozprocess == 0.23 11:32:46 INFO - mozprofile == 0.28 11:32:46 INFO - mozrunner == 6.13 11:32:46 INFO - mozscreenshot == 0.1 11:32:46 INFO - mozsystemmonitor == 0.3 11:32:46 INFO - moztest == 0.8 11:32:46 INFO - mozversion == 1.4 11:32:46 INFO - psutil == 3.1.1 11:32:46 INFO - requests == 1.2.3 11:32:46 INFO - wsgiref == 0.1.2 11:32:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:32: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:46 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 0xdc11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1133630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11bc850>, '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 0x11316d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1131b60>, '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': 'af724c981e2a0f424dbabf99000001e7-1483375803.390749-978377419', '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 11:32:46 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 11:32:46 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 11:32:46 INFO - Using env: {'DISPLAY': ':0', 11:32:46 INFO - 'HOME': '/home/cltbld', 11:32:46 INFO - 'LANG': 'en_US.UTF-8', 11:32:46 INFO - 'LANGUAGE': 'en_US:en', 11:32:46 INFO - 'LOGNAME': 'cltbld', 11:32:46 INFO - 'MAIL': '/var/mail/cltbld', 11:32:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:46 INFO - 'MOZ_NO_REMOTE': '1', 11:32:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:46 INFO - 'NO_EM_RESTART': '1', 11:32:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:46 INFO - 'PWD': '/builds/slave/test', 11:32:46 INFO - 'SHELL': '/bin/bash', 11:32:46 INFO - 'SHLVL': '1', 11:32:46 INFO - 'TERM': 'linux', 11:32:46 INFO - 'TMOUT': '86400', 11:32:46 INFO - 'USER': 'cltbld', 11:32:46 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1483375803.390749-978377419', 11:32:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:46 INFO - '_': '/tools/buildbot/bin/python'} 11:32:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:46 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)) 11:32:46 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)) 11:32:46 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)) 11:32:46 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)) 11:32:46 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)) 11:32:46 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)) 11:32:46 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)) 11:32:46 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)) 11:32:46 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)) 11:32:46 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)) 11:32:46 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)) 11:32:46 INFO - Cleaning up... 11:32:46 INFO - Return code: 0 11:32:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:32: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:46 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 0xdc11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1133630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11bc850>, '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 0x11316d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1131b60>, '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': 'af724c981e2a0f424dbabf99000001e7-1483375803.390749-978377419', '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 11:32:46 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 11:32:46 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 11:32:46 INFO - Using env: {'DISPLAY': ':0', 11:32:46 INFO - 'HOME': '/home/cltbld', 11:32:46 INFO - 'LANG': 'en_US.UTF-8', 11:32:46 INFO - 'LANGUAGE': 'en_US:en', 11:32:46 INFO - 'LOGNAME': 'cltbld', 11:32:46 INFO - 'MAIL': '/var/mail/cltbld', 11:32:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:46 INFO - 'MOZ_NO_REMOTE': '1', 11:32:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:46 INFO - 'NO_EM_RESTART': '1', 11:32:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:46 INFO - 'PWD': '/builds/slave/test', 11:32:46 INFO - 'SHELL': '/bin/bash', 11:32:46 INFO - 'SHLVL': '1', 11:32:46 INFO - 'TERM': 'linux', 11:32:46 INFO - 'TMOUT': '86400', 11:32:46 INFO - 'USER': 'cltbld', 11:32:46 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1483375803.390749-978377419', 11:32:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:46 INFO - '_': '/tools/buildbot/bin/python'} 11:32:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:32:46 INFO - Cleaning up... 11:32:46 INFO - Return code: 0 11:32:46 INFO - Running post-action listener: _resource_record_post_action 11:32:46 INFO - Running post-action listener: _start_resource_monitoring 11:32:46 INFO - Starting resource monitoring. 11:32:46 INFO - [mozharness: 2017-01-02 19:32:46.704635Z] Finished create-virtualenv step (success) 11:32:46 INFO - [mozharness: 2017-01-02 19:32:46.705157Z] Running install step. 11:32:46 INFO - Running pre-action listener: _resource_record_pre_action 11:32:46 INFO - Running main action method: install 11:32:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:32:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:32:46 INFO - Reading from file tmpfile_stdout 11:32:46 INFO - Detecting whether we're running mozinstall >=1.0... 11:32:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:32:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:32:46 INFO - Reading from file tmpfile_stdout 11:32:46 INFO - Output received: 11:32:46 INFO - Usage: mozinstall [options] installer 11:32:46 INFO - Options: 11:32:46 INFO - -h, --help show this help message and exit 11:32:46 INFO - -d DEST, --destination=DEST 11:32:46 INFO - Directory to install application into. [default: 11:32:46 INFO - "/builds/slave/test"] 11:32:46 INFO - --app=APP Application being installed. [default: firefox] 11:32:46 INFO - mkdir: /builds/slave/test/build/application 11:32:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:32:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:33:03 INFO - Reading from file tmpfile_stdout 11:33:03 INFO - Output received: 11:33:03 INFO - /builds/slave/test/build/application/firefox/firefox 11:33:03 INFO - Running post-action listener: _resource_record_post_action 11:33:03 INFO - [mozharness: 2017-01-02 19:33:03.039227Z] Finished install step (success) 11:33:03 INFO - [mozharness: 2017-01-02 19:33:03.039504Z] Running run-tests step. 11:33:03 INFO - Running pre-action listener: _resource_record_pre_action 11:33:03 INFO - Running main action method: run_tests 11:33:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:33:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:33:03 INFO - Python 2.7.3 11:33:03 INFO - Return code: 0 11:33:03 INFO - grabbing minidump binary from tooltool 11:33:03 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:33:03 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 0x11bc850>, '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 0x11316d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1131b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:33:03 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 11:33:03 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 11:33:03 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 11:33:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:33:03 INFO - Return code: 0 11:33:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:33:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:33:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:33:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:33:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:33:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UC_N8bMsR0CJ34QVha7V_w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 11:33:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UC_N8bMsR0CJ34QVha7V_w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 11:33:03 INFO - Using env: {'DISPLAY': ':0', 11:33:03 INFO - 'HOME': '/home/cltbld', 11:33:03 INFO - 'LANG': 'en_US.UTF-8', 11:33:03 INFO - 'LANGUAGE': 'en_US:en', 11:33:03 INFO - 'LOGNAME': 'cltbld', 11:33:03 INFO - 'MAIL': '/var/mail/cltbld', 11:33:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:33:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:33:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:33:03 INFO - 'MOZ_NO_REMOTE': '1', 11:33:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:33:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:33:03 INFO - 'NO_EM_RESTART': '1', 11:33:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:33:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:33:03 INFO - 'PWD': '/builds/slave/test', 11:33:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:33:03 INFO - 'SHELL': '/bin/bash', 11:33:03 INFO - 'SHLVL': '1', 11:33:03 INFO - 'TERM': 'linux', 11:33:03 INFO - 'TMOUT': '86400', 11:33:03 INFO - 'USER': 'cltbld', 11:33:03 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1483375803.390749-978377419', 11:33:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:33:03 INFO - '_': '/tools/buildbot/bin/python'} 11:33:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UC_N8bMsR0CJ34QVha7V_w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 11:33:03 INFO - mozversion application_buildid: 20170102185430 11:33:03 INFO - mozversion application_changeset: c91249f41e3766274131a84f9157a4d9d9949520 11:33:03 INFO - mozversion application_display_name: Nightly 11:33:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:33:03 INFO - mozversion application_name: Firefox 11:33:03 INFO - mozversion application_remotingname: firefox 11:33:03 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:33:03 INFO - mozversion application_vendor: Mozilla 11:33:03 INFO - mozversion application_version: 53.0a1 11:33:03 INFO - mozversion platform_buildid: 20170102185430 11:33:03 INFO - mozversion platform_changeset: c91249f41e3766274131a84f9157a4d9d9949520 11:33:03 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:33:03 INFO - mozversion platform_version: 53.0a1 11:33:03 INFO - using testdate: 1483385583 11:33:03 INFO - actual date: 1483385583 11:33:03 INFO - starting webserver on 'localhost:38360' 11:33:03 INFO - SUITE-START | Running 2 tests 11:33:03 INFO - TEST-START | dromaeo_css 11:33:03 INFO - operating with platform_type : linux_ 11:33:03 INFO - Initialising browser for dromaeo_css test... 11:33:03 INFO - TEST-INFO | started process 27826 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVsp8l9/profile http://localhost:38360/getInfo.html) 11:33:03 INFO - PROCESS | 27826 | 1483385583810 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4986 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2097 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3827 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2831 < callProvider()@resource://gre/modules/AddonManager.jsm:264 < _startProvider()@resource://gre/modules/AddonManager.jsm:771 < startup()@resource://gre/modules/AddonManager.jsm:957 < startup()@resource://gre/modules/AddonManager.jsm:2923 < observe()@resource://gre/components/addonManager.js:65 11:33:07 INFO - PROCESS | 27826 | __metrics Screen width/height:1600/1200 11:33:07 INFO - PROCESS | 27826 | colorDepth:24 11:33:07 INFO - PROCESS | 27826 | Browser inner width/height: 1024/697 11:33:07 INFO - PROCESS | 27826 | __metrics 11:33:08 INFO - PROCESS | 27826 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:33:08 INFO - PROCESS | 27826 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:33:08 INFO - PROCESS | 27826 | console.error: PushService: 11:33:08 INFO - PROCESS | 27826 | stateChangeProcessEnqueue: Error transitioning state 11:33:08 INFO - PROCESS | 27826 | UnknownError 11:33:09 INFO - TEST-INFO | 27826: exit 0 11:33:09 INFO - Browser initialized. 11:33:09 INFO - Running cycle 1/1 for dromaeo_css test... 11:33:09 INFO - TEST-INFO | started process 27907 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVsp8l9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:33:21 INFO - PROCESS | 27907 | RSS: Main: 151056384 11:33:21 INFO - PROCESS | 27907 | 11:34:13 INFO - PROCESS | 27907 | 1483385653187 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] 11:36:25 INFO - PROCESS | 27907 | Cycle 1(1): loaded http://localhost:38360/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38360/tests/dromaeo/cssquery-ext.html) 11:36:27 INFO - PROCESS | 27907 | RSS: Main: 345890816 11:36:27 INFO - PROCESS | 27907 | 11:38:10 INFO - PROCESS | 27907 | ************************* 11:38:10 INFO - PROCESS | 27907 | A coding exception was thrown and uncaught in a Task. 11:38:10 INFO - PROCESS | 27907 | 11:38:10 INFO - PROCESS | 27907 | Full message: ReferenceError: fetch is not defined 11:38:10 INFO - PROCESS | 27907 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 11:38:10 INFO - PROCESS | 27907 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 11:38:10 INFO - PROCESS | 27907 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 11:38:10 INFO - PROCESS | 27907 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 11:38:10 INFO - PROCESS | 27907 | TaskImpl@resource://gre/modules/Task.jsm:277:3 11:38:10 INFO - PROCESS | 27907 | asyncFunction@resource://gre/modules/Task.jsm:252:14 11:38:10 INFO - PROCESS | 27907 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 11:38:10 INFO - PROCESS | 27907 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 11:38:10 INFO - PROCESS | 27907 | TaskImpl@resource://gre/modules/Task.jsm:277:3 11:38:10 INFO - PROCESS | 27907 | asyncFunction@resource://gre/modules/Task.jsm:252:14 11:38:10 INFO - PROCESS | 27907 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 11:38:10 INFO - PROCESS | 27907 | 11:38:10 INFO - PROCESS | 27907 | ************************* 11:39:30 INFO - PROCESS | 27907 | Cycle 1(1): loaded http://localhost:38360/tests/dromaeo/cssquery-ext.html (next: http://localhost:38360/tests/dromaeo/cssquery-jquery.html) 11:39:31 INFO - PROCESS | 27907 | RSS: Main: 238264320 11:39:31 INFO - PROCESS | 27907 | 11:42:33 INFO - PROCESS | 27907 | Cycle 1(1): loaded http://localhost:38360/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38360/tests/dromaeo/cssquery-mootools.html) 11:42:34 INFO - PROCESS | 27907 | RSS: Main: 212791296 11:42:34 INFO - PROCESS | 27907 | 11:45:36 INFO - PROCESS | 27907 | Cycle 1(1): loaded http://localhost:38360/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38360/tests/dromaeo/cssquery-prototype.html) 11:45:37 INFO - PROCESS | 27907 | RSS: Main: 184967168 11:45:37 INFO - PROCESS | 27907 | 11:48:40 INFO - PROCESS | 27907 | Cycle 1(1): loaded http://localhost:38360/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38360/tests/dromaeo/cssquery-yui.html) 11:48:40 INFO - PROCESS | 27907 | RSS: Main: 185470976 11:48:40 INFO - PROCESS | 27907 | 11:51:43 INFO - PROCESS | 27907 | Cycle 1(1): loaded http://localhost:38360/tests/dromaeo/cssquery-yui.html (next: http://localhost:38360/tests/dromaeo/cssquery-dojo.html) 11:51:44 INFO - PROCESS | 27907 | RSS: Main: 263770112 11:51:44 INFO - PROCESS | 27907 | 11:51:44 INFO - PROCESS | 27907 | __start_tp_report 11:51:44 INFO - PROCESS | 27907 | _x_x_mozilla_page_load 11:51:44 INFO - PROCESS | 27907 | _x_x_mozilla_page_load_details 11:51:44 INFO - PROCESS | 27907 | |i|pagename|runs| 11:51:44 INFO - PROCESS | 27907 | |0;dojo.html;2563.3976015636326;2577.987110064452;2606.1139212667695;2611.9477610447793;2612.6864776226844;4688.413948256468;4746.857594272169;4757.6193904487645;4758.952410475894;4774.498677638846;4734.928976065353;4773.832915847946;4809.182438985372;4816.109019831334;4865.172920603497;4322.762248076347;4343.087951530167;4383.232934236512;4422.933655995163;4481.2381895077915;4010.6791456683395;4343.19650864591;4395.956040439587;4425.513193548707;4465.040016396474;4235.0682849773;4256.255155347832;4373.846915357947;4385.232584297735;4461.219286624844;4299.312110062407;4314.201872653538;4315.050688848449;4315.525292217853;4316.223079845627;4253.21315556623;4299.204647140289;4301.182775272689;4301.827926882921;4306.569343065668;4687.906241875144;4692.483826779086;4718.528147185289;4742.928856067162;4835.782389792468;5082.1360368737405;5088.720120393377;5093.439721630654;5132.897342053138;5135.589152867761;5121.641485096045;5130.127878260705;5133.820316288912;5136.8202112925865;5181.792728290864;4735.715857048588;4738.905221895543;4773.641976851715;4782.139214941274;4784.760761961888;5164.509371609691;5209.583233341324;5221.399539052982;5253.763580638881;5310.389305229871;4963.60291176705;4999.450060493343;5014.648974571818;5019.949800502021;5061.164907790173;4984.3021976923255;5046.142155833517;5108.055009823194;5109.642325037212;5113.53978141969;4945.727984960861;5032.672876263031;5076.035553244946;5100.336956195671;5164.638475306692;5096.464871188546;5112.513228041507;5112.795488180505;5113.718745469035;5114.641975061784;4287.8070486828165;4287.892802679896;4290.034742183047;4321.351797230441;4332.155229730172;3598.3163198992106;3609.205974685565;3657.9451308230396;3684.8341824617955;3692.981535092361;4427.623651989553;4428.844990425319;4432.113577284556;4463.955360446354;4468.195724769573;5142.280080788692;5153.742312884341;5159.793608255628;5162.561182299547;5206.245094461282;4333.068390296038;4365.192439398721;4370.8033138508845;4419.40338054365;4425.734455932655;4518.819247230074;4568.520305367955;4574.405327307495;4579.06129243511;4602.861914142581;4804.303376010529;4806.158922188673;4806.375171227718;4807.735574543433;4861.611071114373;4947;4950.356453661145;5121.206213036985;5124.154514505065;5160.509751573594;4788.377510923558;4791.377120974251;4806.975965120152;4854;4896.706197628154;5056.241563765465;5057.7724002419245;5060.544550990428;5063.3417655704525;5106.923396149135;4893.951060489492;5116.565091967224;5135.075686376488;5137.306463627362;5139.794408223779;4708.034852855088;4873.025394921101;4905.926411103907;4908.705477671351;4984.551390374883;4927.704337739747;4936.185529387754;4937.9012419752125;4938.160512712776;4980.203167493184;4617.538246175355;4634.351190833218;4642.883927901695;4700.858974230779;4872.634552408655;4751.073540659539;4782.163121453801;4788.521147885183;4791.5687588117235;4800.807967681254;4636.44362676481;4694.037722266995;4695.295705644044;4700.811967521261;4703.3885594872445 11:51:44 INFO - PROCESS | 27907 | |1;ext.html;536.5332161019913;558.1850498272524;566.6260268222971;567.3843879390861;583.7198144890455;36194.638053619456;38295.23409531811;38528.03679908;42575.78712106443;42598.57401425985;38965.415518767244;39330.60669393305;39374.21251574974;39413.21173576527;39437.21125577487;7366.079240094989;7544.735934242302;7638.045244344471;7835.451518393715;7837.647305871249;10027.448490333029;10355.534000969974;10360.378377297386;10374;10374.792504149913;10068.14420774235;10128;10141;10144.239182061337;10147.188224941987;10068.848967265498;10100.898991010106;10105.444200568965;10128.240381971307;10138.138258247984;9920.95039524805;9999.400035997864;10001;10001.699949001542;10003.949980250125;37540.249195015946;37920.62079379198;38047.619523804686;38047.809760951015;38070.80964595187;3706.3143318485895;3786.1291902862495;3803.391457366808;3818.4845045918723;3833.099221682902;28242.29394265139;28376.574351384745;28435.715642843512;28602;29284.803639727106;3329.9833500832583;3408.5398471206317;3469.3061387722555;3551.0944709099012;3563.2160924596546;230200;231887;232012;232274;232469;47430.28854567184;47924.52075479201;47934.520654793705;47938.280925786145;48009.5199048012;49070.75464622654;49151.508484914695;49219.031238750045;49232;49255.50744492509;13133.671658208621;13355;13362.398692058881;13363.198208107351;13364.866351336557;7528.548287102792;7667.808304792313;9420.62317507292;10056.29605927578;10250.487475626338;15696.76454853178;15746.763798542803;15754.9212253938;15781.132037738034;15816.92091539558;6327.272363678144;6329.303776584572;6459.644719540376;6470.2559205691;6648.933510664928;787.8542469643135;793.8729803231455;819.7335865843625;821.8233079887733;839.139881621343;26478.470430591282;27375.315617109733;28037.616802571603;28047.298817529725;28048.85975570109;969.1229437359201;972.6595691507915;976.4629453800381;984.9556769945369;985.8373368394278;13584.388702508213;14483.275836208148;14716.705665886837;14870.776938345933;14930.10419374841;345541;347176;347329;347373;348072;47683;48369;48387.887029602876;48409.5159048412;48471.75764121157;1193.40926241511;1198.2725311917588;1232.9198602090835;1236.9876301237232;1246.214884622682;25370.873145634152;26421.73578264193;26652.20043398701;26923.730762692907;27071.1878643641;40868.386974194815;41375.7931210342;41475;41563.37654935239;41614.58385416107;220561;223139;223331;223582;224226;22533.774662253825;23114.537709245385;24100.75899240985;24985.625215622145;25198;40036.39945400763;40112.59887401089;40324.79837600793;40609.79695101624;40629.39055914223;33726;34477.82761086179;34743;34875.47686784751;35469.82265088658;33940.15149621279;34467.482987755706;34468.31063378769;34599.82700086483;34722.47916281207;32989;33175.50236746499;33234.16914577155;33639.66360336365;33907.321853563284;28907.429083754305;31235.37529249448;31317.373652527276;31340.216494587818;31500.695528177872;23696.28911132669;23786.286411406993;23891.402714932265;24326;24377.26868193957 11:51:44 INFO - PROCESS | 27907 | |2;jquery.html;348.9371913055649;360.5331096230383;368.23039846720354;375.6074901727694;392.68585131894497;12632;15613;15718;16602.169891505437;16745.497635070966;16709.66580668389;16719.749203761952;16743.83256167438;16863.40978065768;16865.578360540992;4944.703317800934;5164.277001219813;5170.922436163461;5375.973120134394;5439.564834813205;3650.142216579102;5442.156465747816;5477.890442191154;5486.588505862056;5488.69812160331;3811.1424929390805;6598.736050557972;6870.931290687104;6893.896591551131;6895.448364130857;6665.533412661116;6666.266710661824;6755.223149337815;6862.627474505119;6890;6603.108580341641;6667.766298290078;6672.199336079701;6677.265500794909;6679.165104361955;21695;21874.125034998582;21973.450663733376;22188.334349969526;22201.44496387587;2190.2772085212;2300.298408985259;2352.8588284702973;2394.353524548362;2397.724261709908;13446.193228406328;13512.797308040388;13682.179069255777;13767.242801645905;14194.716105677828;1824.1608859924452;1861.1159699142934;1873.297513432463;1880.7272945422974;1918.4628304074881;54409.45590544123;64332.67833660802;66113.33886661168;70384.29615703829;71979;15317.23413829304;15344.693106137815;15611.843881561266;15917.840821591635;15919.442819501493;26453.47093058128;26514.734852651225;26544.734552654227;26598.335041623726;26742;8336.541490218096;8456.746297611082;8491.872621910676;8550.444221125606;8644.308455323559;6972.546784458994;7011.439084873198;7156.892646610305;7163.283671632899;7190.137183538009;7933.286004259644;8079.434439589172;8083.595820208966;8117;8154.5536339098035;3299.736021118305;3327.73378129749;3385.153711572107;3385.3398587275738;3396.7961922284744;749.7375918428506;773.524282566229;777.4014009212988;793.0998316910349;793.9757712550745;14196.432142714175;14950.62623434401;15230.847691523164;15677.608059798367;16021.919890400706;775.693601027591;776.1346099099576;781.620913856779;791.189031242969;792.2343189164585;8574.969764210811;8662.913370866338;8885.466871987572;8941.329400295004;9138.725838224864;291945;296760;296969;297344.2124630024;298021;69242.72951340137;69359.65320173367;70515.29484705087;70925.2907470929;72981.6350918242;879.9560021998874;896.171041786345;915.1306259053925;918.3433844801;927.4435338796668;13803;13818.447262109403;13922.860771392561;13925.860741392456;14382.424703011762;27282.590761138996;34289.314213715086;35349.82325088358;36302.636973629924;36334.636653633126;41703.58296416997;43995;45875;47866.760666196446;50949.49050509596;7490.475666703279;7610.429217808576;7615.753352760838;7661.272179142972;7880;9177.449353038839;11273.774524509628;11465.713357166138;11918.821217681914;11993.760124797629;5242.580593552583;9593.232541396812;10170.796584068425;10225.43760093202;10535.683929482127;9611.855822162814;9637.42175469474;9863.731341791285;10007;10404.167666586503;9527.904720952702;9786.951065244628;9868.506574671093;9883.802323953338;10117.494125293559;7107.182673992557;7545.170031296443;7574.394048475999;7754.302112809874;7779.210781520169;8987.685431009882;9253.907460925304;9449.858252126362;9497.905020949978;9558.85661715061 11:51:44 INFO - PROCESS | 27907 | |3;mootools.html;1306.4055854586163;1316.6247619428466;1329.2954733990985;1330.0357241000277;1331.4008696086764;6960.164780226367;7371.852562948745;7376.4098872090235;7381.557106573596;7394.778156655302;6527.477801775858;6753.324667533244;7095.6806943687525;7274.563526188419;7307.744228951974;2154.439845640133;2192.6491761318193;2196.846220764547;2198.7251593550805;2200.2299195281603;2137.668661357492;2187.3437968609433;2192.9890350548303;2197.044285735702;2202.1411649456722;1828.5794267318524;1888.037101078446;2039.9184032638677;2105.0632468551503;2151.9031643576077;2146.8711877287333;2164.0910817456706;2165.935021949344;2166.360923527563;2167.9241226556996;2138.967915481269;2144.8820314882673;2148.9247876324253;2163.9242626508;2165.2962787094257;7078.610676412795;7224.67488962998;7236.746713865042;7237.674304656303;7238.27617238272;4458.152950939311;4593.724376537419;4595.241785105453;4596.241620132674;4597.770111494446;2853.2296280004284;2952.099609619065;3034.044276053058;3042.5131978883273;3055.5874956880757;1066.7333166708322;1115.6318414923137;1132.0999805154922;1167.5504930601694;1187.4300335838846;9761.07269809367;9801.411915285105;9804.509774511245;9806.16647584949;9818.803623927553;3975.8012099394914;4211.389348544444;4275.102228532043;4298.78506074695;4307.956920430818;8466;8476.703315383931;8479.830403391898;8482.618282177316;8483.321334293241;4644.95355046452;4645.512221216723;4647.256438969748;4650.209464390994;4656.348111264426;3630.5098811660087;3641.8361173747244;4073.4704488416314;4255.297875850512;4266.274733295348;3485.546878905726;3507.9649203508147;3582.7671201371827;3587.5336206293014;3612.458131280329;1176.129664048598;1216.5255550335376;1219.1222319929814;1221.8900298973135;1229.538922903911;791.2364568191723;814.6578437056451;836.4228682209256;836.4604829884812;851.2891735400885;4798.424189097331;4881.585065269421;4901.166801643729;5008.1486147355035;5139.7687104080405;872.7032808845023;908.8500397434482;921.6909560313777;930.6412637549254;935.2845073518764;3426.9657303427143;3434.175797808508;3456.1186897341017;3496.3182179474757;3542.167590616203;8756.649734010696;8923.419977701558;8986.19124278818;9002.459852408876;9005.324600654978;8963.148500892405;8978.191962723386;8980.281577473917;8982.775430614287;8986.415882967585;6582.243042050225;6736.7642132525125;6838.179418469816;6966.512344135862;6968.825779355557;4687.906241875212;4900.754962251945;4961.305417241517;5050.98980203968;5104.897902042013;7931.510522709026;8174.223448772357;8207.466514676527;8218.958905205674;8274.875876861732;7481.812954676177;8269.04905935801;8350.916490835014;8367.623456944573;8368.330533557422;5910.911336330045;6096.939030609815;6419.582727122722;6594.208694956636;6625.50308726857;6866.176058872968;6998.790036298919;7047.647617619201;7220.422366210795;7235.529690570096;6394.392532709385;6438.3883531064475;6442.162518872517;6588.670566471753;6660.600363978177;6270.623762574261;6274.090256912813;6291.874162516816;6302.243730752339;6329.873402531832;5650.039493286069;5772.740226689725;5789.623674461147;5790.913136302875;5796.159556864147;4259.574042595716;4398.4165700348485;4435.024294655171;4470.552944705503;4473.619742321939;4263.680223983276;4275.059486912998;4323.200207961537;4337.15425492026;4372.060007098489 11:51:44 INFO - PROCESS | 27907 | |4;prototype.html;350.98947031589046;352.9929401411972;355.25928439204256;360.19496425489046;363.95450568678916;4796.953934251749;4810.374651295331;4819.277108433736;4845.418549774032;4854.878628034301;4777.570018698317;4779.115863565243;4789.473157952622;4801.927971080428;4814.325994360793;3674.816259187043;3775.5469343678797;3781.7163712721517;3839;3873.98063009686;3853.5761066282685;3863.6715879150306;3867.3425517662067;3879.5926427724967;3882.165334453092;3835;3842.884713458601;3848.018270590648;3848.6536211740936;3854.036490877281;3679.8896033118917;3694.5935947046073;3792;3809.904752381213;3811.9618803811886;3450.258194488197;3453.4474484082675;3459.0487615905577;3464.683420300295;3472.58329000519;4673.158831410345;4682.227432473638;4696.976515117402;4701;4706.670533062687;4034.7377420467574;4208.705390622657;4367.432233809616;4373.234683930331;4384.868453946387;4948.604111671058;4961.305417241589;4973.3286006389035;4978.77595508203;4980.601551875841;3550.715942724576;3556.199855032623;3564.946525802115;3571.5178450909057;3578.570571531433;5006.849794506098;5145.459726728677;5158.246196293241;5179.585633149339;5221.190715439113;3625.8549658013912;3636.1818590816856;3638.1632224588493;3659.597444281127;3662.1393972416463;3672.6510981456718;3683.778973261613;3686.502322186524;3696.4085746280466;3706.8517259309865;4180.853670121531;4187.099773548702;4193.412922190896;4207.8316867325575;4208.473940757405;4810.759462026885;4939;4945.9258111128365;4959.479254678279;4968.826091086795;1233.5065973610629;1235.3329202230875;1235.5799028330412;1238.7089034076985;1238.7089034077164;821.93013593844;859.8882145321194;862.7886167888907;864.7319331007408;870.4342177584494;4186.372044193396;4262.936055959163;4306.707987603706;4349.998501034276;4390.09031071485;5139.794408223629;5142.717150556755;5152.098382783073;5158.6131040171385;5162.199859021857;4378.5183629800695;4417.911641767211;4421.668374871898;4426.44669416323;4435.489918659331;2557.9104731334314;2642.5507663697217;2649.576067829138;2670.8531030793492;2692.9192124236306;4670.1827180244;4671.6262698984;4692.7653617319;4770.236762118045;4790.640701947368;5028.949710502921;5035.571976381975;5049.6212784041345;5072.695638261716;5074.847754567369;4449.221386257392;4659.930101048487;4727.456342520654;4735.33705281254;4744.264638980894;4976.701397916137;4991.5258050485145;4994.127202299138;4997.175466048061;5020.774065167003;4868.488808675038;4868.48880867518;4898.2652602109965;4914.827981020647;4933.235348520985;4571.748553829571;4825.879353016203;4884.902301954012;4891.95108048915;4893.412790465167;3688.815559222082;3692.5015122958057;3694.3719567674098;3713.6472035156617;3716.256748650335;5137.126688463045;5137.8201762938115;5146.4338922717725;5148.7425628717665;5170.586353091819;4789.760511974457;4885.193942999365;4915.361003069578;4923.532264434873;4935.827246046371;4898.412190537016;4920.21276595743;4948.257761335828;4953.306537084739;4953.529414705597;4879.780409881635;4885.609151267819;4891.926621100615;4900.975495122644;4912.6561140719805;4729.55069268419;4824.927626085541;4856.708597484162;4910;4948.1835497142565;4718.655183272751;4838;4841.2496063110275;4842.4673285939225;4845.53967373099 11:51:44 INFO - PROCESS | 27907 | |5;yui.html;664.9667516624168;683.2040672616399;738.9741359052432;739.2127384335682;747.0960138232738;12662.810057849128;13554.322283885804;13563.389647465863;13574.728505429886;13609.863901360983;12740.235585864832;12805.487780488793;12818;12838.679033024178;12916.677083072927;669.2337273821471;688.703857341343;789.6999140326697;791.0428381658201;812.5815205169342;822.8642274024779;828.6105530400702;828.8052307707684;829.050736906242;829.402829962426;866.7919699272161;869.0961400143843;869.1525762381691;869.2481003931586;869.2654706772798;690.6615758278458;711.0187940641881;711.2745000099869;714.9392301654366;865.3380164174412;609.5306613907267;630.1461519640912;635.8823617630753;636.723025483916;636.9936300636981;12895.935520322431;12912.354382280848;12923.547675831302;12925.224486530744;12926.87073129266;12081.708375307995;12208.206466579644;12281.324527151002;12328.568500102454;12440.129190956637;11443.141764367623;11452.484638191301;11481.540738370455;11501.942490287494;12055.93972030143;4056.7565946043333;4074.670709750797;4119.176164767028;4141.213169497786;4146.751194928314;56394.154087688716;57056.714716426155;57325;57931.71034144802;59786.402135978955;9465.479398633004;9698.563564639608;9898.554565044591;9916.603335866484;9918.40489570628;18492.630147396976;18601.162947667388;18643;18676.34632787846;18765.24939002452;5914.940850591525;5980.850478738066;6066.211392519032;6102.755889764359;6128.63228206309;3316.369889720945;3421.298633780069;3438.8796392126155;3441.8107004114513;3451.9654803452145;2652.204338698383;2717.823341482837;2727.8090533662453;2728.3451971526692;2730.494858451193;444.06967403290054;450.1626973828676;450.16719069720756;455.98404055857884;457.00601192406384;578.4938179093293;601.8375038739516;603.9426254505815;604.3714536881594;608.9878202436015;7849.764507064683;7863.719521338748;8014.270623642263;8135.918640813635;8160.428769986044;563.194631676698;578.2858170159849;598.5989387110646;602.2923065398227;613.8772245550819;3759.6259216835465;3930.606939306104;3950.6839452843706;3985.342418500973;4029.576894426043;53596;54100;63307.6834615824;64277;65149.348506514325;53856.46143538514;54363.45636543663;54505;55492.445075549535;55867.720661397245;40928.79535602303;51896;52101.478985209666;52153.7392313036;53247.467525325024;7323.8535229296185;7616.809579760328;7728.998151718134;7796.220377962159;7808.882866757117;36370.09074773152;36532;36677.63322366742;36892.26215475729;37970.240595188494;42466.15067698567;44489;44848;45382.54617453915;46835.53164468312;9702.320837541305;9750.951245243728;9821.705348839547;9846.212303015885;10095;10552.419616921143;10770.623028193975;10802.837957430487;10812.513436895515;10881.401522916;9438.811223775623;9509.286803489627;9823.459709716035;10047.74880627961;10257.33327333721;9747;10285.177185825265;10373.844392333971;10457.320274182153;10701.678949631523;9692.22462203008;9928.851067234142;10161.085502304828;10255.794884102426;10279.53742081623;8102.837943240984;8515.701950431705;8657.350698697497;8669.133086691281;9070.863937040818;8260.421770476249;8622.525761083201;8629.26651234627;8682.869756953776;8786.516741579018 11:51:44 INFO - PROCESS | 27907 | __end_tp_report 11:51:44 INFO - PROCESS | 27907 | __start_cc_report 11:51:44 INFO - PROCESS | 27907 | _x_x_mozilla_cycle_collect,2255 11:51:44 INFO - PROCESS | 27907 | __end_cc_report 11:51:44 INFO - PROCESS | 27907 | __startTimestamp1483386704061__endTimestamp 11:51:44 INFO - PROCESS | 27907 | 11:51:44 INFO - PROCESS | 27907 | ------- Summary: start ------- 11:51:44 INFO - PROCESS | 27907 | Number of tests: 6 11:51:44 INFO - PROCESS | 27907 | 11:51:44 INFO - PROCESS | 27907 | [#0] dojo.html Cycles:165 Average:4678.65 Median:4784.76 stddev:511.94 (10.7%) stddev-sans-first:485.88 11:51:44 INFO - PROCESS | 27907 | Values: 2563.4 2578.0 2606.1 2611.9 2612.7 4688.4 4746.9 4757.6 4759.0 4774.5 4734.9 4773.8 4809.2 4816.1 4865.2 4322.8 4343.1 4383.2 4422.9 4481.2 4010.7 4343.2 4396.0 4425.5 4465.0 4235.1 4256.3 4373.8 4385.2 4461.2 4299.3 4314.2 4315.1 4315.5 4316.2 4253.2 4299.2 4301.2 4301.8 4306.6 4687.9 4692.5 4718.5 4742.9 4835.8 5082.1 5088.7 5093.4 5132.9 5135.6 5121.6 5130.1 5133.8 5136.8 5181.8 4735.7 4738.9 4773.6 4782.1 4784.8 5164.5 5209.6 5221.4 5253.8 5310.4 4963.6 4999.5 5014.6 5019.9 5061.2 4984.3 5046.1 5108.1 5109.6 5113.5 4945.7 5032.7 5076.0 5100.3 5164.6 5096.5 5112.5 5112.8 5113.7 5114.6 4287.8 4287.9 4290.0 4321.4 4332.2 3598.3 3609.2 3657.9 3684.8 3693.0 4427.6 4428.8 4432.1 4464.0 4468.2 5142.3 5153.7 5159.8 5162.6 5206.2 4333.1 4365.2 4370.8 4419.4 4425.7 4518.8 4568.5 4574.4 4579.1 4602.9 4804.3 4806.2 4806.4 4807.7 4861.6 4947.0 4950.4 5121.2 5124.2 5160.5 4788.4 4791.4 4807.0 4854.0 4896.7 5056.2 5057.8 5060.5 5063.3 5106.9 4894.0 5116.6 5135.1 5137.3 5139.8 4708.0 4873.0 4905.9 4908.7 4984.6 4927.7 4936.2 4937.9 4938.2 4980.2 4617.5 4634.4 4642.9 4700.9 4872.6 4751.1 4782.2 4788.5 4791.6 4800.8 4636.4 4694.0 4695.3 4700.8 4703.4 11:51:44 INFO - PROCESS | 27907 | 11:51:44 INFO - PROCESS | 27907 | [#1] ext.html Cycles:180 Average:42437.76 Median:34473.07 stddev:71528.66 (207.5%) stddev-sans-first:71660.13 11:51:44 INFO - PROCESS | 27907 | Values: 536.5 558.2 566.6 567.4 583.7 36194.6 38295.2 38528.0 42575.8 42598.6 38965.4 39330.6 39374.2 39413.2 39437.2 7366.1 7544.7 7638.0 7835.5 7837.6 10027.4 10355.5 10360.4 10374.0 10374.8 10068.1 10128.0 10141.0 10144.2 10147.2 10068.8 10100.9 10105.4 10128.2 10138.1 9921.0 9999.4 10001.0 10001.7 10003.9 37540.2 37920.6 38047.6 38047.8 38070.8 3706.3 3786.1 3803.4 3818.5 3833.1 28242.3 28376.6 28435.7 28602.0 29284.8 3330.0 3408.5 3469.3 3551.1 3563.2 230200.0 231887.0 232012.0 232274.0 232469.0 47430.3 47924.5 47934.5 47938.3 48009.5 49070.8 49151.5 49219.0 49232.0 49255.5 13133.7 13355.0 13362.4 13363.2 13364.9 7528.5 7667.8 9420.6 10056.3 10250.5 15696.8 15746.8 15754.9 15781.1 15816.9 6327.3 6329.3 6459.6 6470.3 6648.9 787.9 793.9 819.7 821.8 839.1 26478.5 27375.3 28037.6 28047.3 28048.9 969.1 972.7 976.5 985.0 985.8 13584.4 14483.3 14716.7 14870.8 14930.1 345541.0 347176.0 347329.0 347373.0 348072.0 47683.0 48369.0 48387.9 48409.5 48471.8 1193.4 1198.3 1232.9 1237.0 1246.2 25370.9 26421.7 26652.2 26923.7 27071.2 40868.4 41375.8 41475.0 41563.4 41614.6 220561.0 223139.0 223331.0 223582.0 224226.0 22533.8 23114.5 24100.8 24985.6 25198.0 40036.4 40112.6 40324.8 40609.8 40629.4 33726.0 34477.8 34743.0 34875.5 35469.8 33940.2 34467.5 34468.3 34599.8 34722.5 32989.0 33175.5 33234.2 33639.7 33907.3 28907.4 31235.4 31317.4 31340.2 31500.7 23696.3 23786.3 23891.4 24326.0 24377.3 11:51:44 INFO - PROCESS | 27907 | 11:51:44 INFO - PROCESS | 27907 | [#2] jquery.html Cycles:180 Average:21918.43 Median:5309.28 stddev:49213.78 (926.9%) stddev-sans-first:49325.19 11:51:44 INFO - PROCESS | 27907 | Values: 348.9 360.5 368.2 375.6 392.7 12632.0 15613.0 15718.0 16602.2 16745.5 16709.7 16719.7 16743.8 16863.4 16865.6 4944.7 5164.3 5170.9 5376.0 5439.6 3650.1 5442.2 5477.9 5486.6 5488.7 3811.1 6598.7 6870.9 6893.9 6895.4 6665.5 6666.3 6755.2 6862.6 6890.0 6603.1 6667.8 6672.2 6677.3 6679.2 21695.0 21874.1 21973.5 22188.3 22201.4 2190.3 2300.3 2352.9 2394.4 2397.7 13446.2 13512.8 13682.2 13767.2 14194.7 1824.2 1861.1 1873.3 1880.7 1918.5 54409.5 64332.7 66113.3 70384.3 71979.0 15317.2 15344.7 15611.8 15917.8 15919.4 26453.5 26514.7 26544.7 26598.3 26742.0 8336.5 8456.7 8491.9 8550.4 8644.3 6972.5 7011.4 7156.9 7163.3 7190.1 7933.3 8079.4 8083.6 8117.0 8154.6 3299.7 3327.7 3385.2 3385.3 3396.8 749.7 773.5 777.4 793.1 794.0 14196.4 14950.6 15230.8 15677.6 16021.9 775.7 776.1 781.6 791.2 792.2 8575.0 8662.9 8885.5 8941.3 9138.7 291945.0 296760.0 296969.0 297344.2 298021.0 69242.7 69359.7 70515.3 70925.3 72981.6 880.0 896.2 915.1 918.3 927.4 13803.0 13818.4 13922.9 13925.9 14382.4 27282.6 34289.3 35349.8 36302.6 36334.6 41703.6 43995.0 45875.0 47866.8 50949.5 7490.5 7610.4 7615.8 7661.3 7880.0 9177.4 11273.8 11465.7 11918.8 11993.8 5242.6 9593.2 10170.8 10225.4 10535.7 9611.9 9637.4 9863.7 10007.0 10404.2 9527.9 9787.0 9868.5 9883.8 10117.5 7107.2 7545.2 7574.4 7754.3 7779.2 8987.7 9253.9 9449.9 9497.9 9558.9 11:51:44 INFO - PROCESS | 27907 | 11:51:44 INFO - PROCESS | 27907 | [#3] mootools.html Cycles:180 Average:4858.76 Median:4984.73 stddev:2607.98 (52.3%) stddev-sans-first:2601.63 11:51:44 INFO - PROCESS | 27907 | Values: 1306.4 1316.6 1329.3 1330.0 1331.4 6960.2 7371.9 7376.4 7381.6 7394.8 6527.5 6753.3 7095.7 7274.6 7307.7 2154.4 2192.6 2196.8 2198.7 2200.2 2137.7 2187.3 2193.0 2197.0 2202.1 1828.6 1888.0 2039.9 2105.1 2151.9 2146.9 2164.1 2165.9 2166.4 2167.9 2139.0 2144.9 2148.9 2163.9 2165.3 7078.6 7224.7 7236.7 7237.7 7238.3 4458.2 4593.7 4595.2 4596.2 4597.8 2853.2 2952.1 3034.0 3042.5 3055.6 1066.7 1115.6 1132.1 1167.6 1187.4 9761.1 9801.4 9804.5 9806.2 9818.8 3975.8 4211.4 4275.1 4298.8 4308.0 8466.0 8476.7 8479.8 8482.6 8483.3 4645.0 4645.5 4647.3 4650.2 4656.3 3630.5 3641.8 4073.5 4255.3 4266.3 3485.5 3508.0 3582.8 3587.5 3612.5 1176.1 1216.5 1219.1 1221.9 1229.5 791.2 814.7 836.4 836.5 851.3 4798.4 4881.6 4901.2 5008.1 5139.8 872.7 908.9 921.7 930.6 935.3 3427.0 3434.2 3456.1 3496.3 3542.2 8756.6 8923.4 8986.2 9002.5 9005.3 8963.1 8978.2 8980.3 8982.8 8986.4 6582.2 6736.8 6838.2 6966.5 6968.8 4687.9 4900.8 4961.3 5051.0 5104.9 7931.5 8174.2 8207.5 8219.0 8274.9 7481.8 8269.0 8350.9 8367.6 8368.3 5910.9 6096.9 6419.6 6594.2 6625.5 6866.2 6998.8 7047.6 7220.4 7235.5 6394.4 6438.4 6442.2 6588.7 6660.6 6270.6 6274.1 6291.9 6302.2 6329.9 5650.0 5772.7 5789.6 5790.9 5796.2 4259.6 4398.4 4435.0 4470.6 4473.6 4263.7 4275.1 4323.2 4337.2 4372.1 11:51:44 INFO - PROCESS | 27907 | 11:51:44 INFO - PROCESS | 27907 | [#4] prototype.html Cycles:180 Average:4132.58 Median:4712.66 stddev:1173.75 (24.9%) stddev-sans-first:1142.21 11:51:44 INFO - PROCESS | 27907 | Values: 351.0 353.0 355.3 360.2 364.0 4797.0 4810.4 4819.3 4845.4 4854.9 4777.6 4779.1 4789.5 4801.9 4814.3 3674.8 3775.5 3781.7 3839.0 3874.0 3853.6 3863.7 3867.3 3879.6 3882.2 3835.0 3842.9 3848.0 3848.7 3854.0 3679.9 3694.6 3792.0 3809.9 3812.0 3450.3 3453.4 3459.0 3464.7 3472.6 4673.2 4682.2 4697.0 4701.0 4706.7 4034.7 4208.7 4367.4 4373.2 4384.9 4948.6 4961.3 4973.3 4978.8 4980.6 3550.7 3556.2 3564.9 3571.5 3578.6 5006.8 5145.5 5158.2 5179.6 5221.2 3625.9 3636.2 3638.2 3659.6 3662.1 3672.7 3683.8 3686.5 3696.4 3706.9 4180.9 4187.1 4193.4 4207.8 4208.5 4810.8 4939.0 4945.9 4959.5 4968.8 1233.5 1235.3 1235.6 1238.7 1238.7 821.9 859.9 862.8 864.7 870.4 4186.4 4262.9 4306.7 4350.0 4390.1 5139.8 5142.7 5152.1 5158.6 5162.2 4378.5 4417.9 4421.7 4426.4 4435.5 2557.9 2642.6 2649.6 2670.9 2692.9 4670.2 4671.6 4692.8 4770.2 4790.6 5028.9 5035.6 5049.6 5072.7 5074.8 4449.2 4659.9 4727.5 4735.3 4744.3 4976.7 4991.5 4994.1 4997.2 5020.8 4868.5 4868.5 4898.3 4914.8 4933.2 4571.7 4825.9 4884.9 4892.0 4893.4 3688.8 3692.5 3694.4 3713.6 3716.3 5137.1 5137.8 5146.4 5148.7 5170.6 4789.8 4885.2 4915.4 4923.5 4935.8 4898.4 4920.2 4948.3 4953.3 4953.5 4879.8 4885.6 4891.9 4901.0 4912.7 4729.6 4824.9 4856.7 4910.0 4948.2 4718.7 4838.0 4841.2 4842.5 4845.5 11:51:44 INFO - PROCESS | 27907 | 11:51:44 INFO - PROCESS | 27907 | [#5] yui.html Cycles:180 Average:14049.92 Median:55680.08 stddev:17435.35 (31.3%) stddev-sans-first:17455.28 11:51:44 INFO - PROCESS | 27907 | Values: 665.0 683.2 739.0 739.2 747.1 12662.8 13554.3 13563.4 13574.7 13609.9 12740.2 12805.5 12818.0 12838.7 12916.7 669.2 688.7 789.7 791.0 812.6 822.9 828.6 828.8 829.1 829.4 866.8 869.1 869.2 869.2 869.3 690.7 711.0 711.3 714.9 865.3 609.5 630.1 635.9 636.7 637.0 12895.9 12912.4 12923.5 12925.2 12926.9 12081.7 12208.2 12281.3 12328.6 12440.1 11443.1 11452.5 11481.5 11501.9 12055.9 4056.8 4074.7 4119.2 4141.2 4146.8 56394.2 57056.7 57325.0 57931.7 59786.4 9465.5 9698.6 9898.6 9916.6 9918.4 18492.6 18601.2 18643.0 18676.3 18765.2 5914.9 5980.9 6066.2 6102.8 6128.6 3316.4 3421.3 3438.9 3441.8 3452.0 2652.2 2717.8 2727.8 2728.3 2730.5 444.1 450.2 450.2 456.0 457.0 578.5 601.8 603.9 604.4 609.0 7849.8 7863.7 8014.3 8135.9 8160.4 563.2 578.3 598.6 602.3 613.9 3759.6 3930.6 3950.7 3985.3 4029.6 53596.0 54100.0 63307.7 64277.0 65149.3 53856.5 54363.5 54505.0 55492.4 55867.7 40928.8 51896.0 52101.5 52153.7 53247.5 7323.9 7616.8 7729.0 7796.2 7808.9 36370.1 36532.0 36677.6 36892.3 37970.2 42466.2 44489.0 44848.0 45382.5 46835.5 9702.3 9751.0 9821.7 9846.2 10095.0 10552.4 10770.6 10802.8 10812.5 10881.4 9438.8 9509.3 9823.5 10047.7 10257.3 9747.0 10285.2 10373.8 10457.3 10701.7 9692.2 9928.9 10161.1 10255.8 10279.5 8102.8 8515.7 8657.4 8669.1 9070.9 8260.4 8622.5 8629.3 8682.9 8786.5 11:51:44 INFO - PROCESS | 27907 | -------- Summary: end -------- 11:51:44 INFO - PROCESS | 27907 | 11:51:44 INFO - TEST-INFO | 27907: exit 0 11:51:44 INFO - TEST-OK | dromaeo_css | took 1121596ms 11:51:44 INFO - TEST-START | kraken 11:51:44 INFO - operating with platform_type : linux_ 11:51:44 INFO - Initialising browser for kraken test... 11:51:44 INFO - TEST-INFO | started process 28209 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpecRAnN/profile http://localhost:38360/getInfo.html) 11:51:45 INFO - PROCESS | 28209 | 1483386705424 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4986 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2097 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3827 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2831 < callProvider()@resource://gre/modules/AddonManager.jsm:264 < _startProvider()@resource://gre/modules/AddonManager.jsm:771 < startup()@resource://gre/modules/AddonManager.jsm:957 < startup()@resource://gre/modules/AddonManager.jsm:2923 < observe()@resource://gre/components/addonManager.js:65 11:51:49 INFO - PROCESS | 28209 | __metrics Screen width/height:1600/1200 11:51:49 INFO - PROCESS | 28209 | colorDepth:24 11:51:49 INFO - PROCESS | 28209 | Browser inner width/height: 1024/697 11:51:49 INFO - PROCESS | 28209 | __metrics 11:51:49 INFO - PROCESS | 28209 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:51:49 INFO - PROCESS | 28209 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:51:50 INFO - PROCESS | 28209 | console.error: PushService: 11:51:50 INFO - PROCESS | 28209 | stateChangeProcessEnqueue: Error transitioning state 11:51:50 INFO - PROCESS | 28209 | UnknownError 11:51:51 INFO - TEST-INFO | 28209: exit 0 11:51:51 INFO - Browser initialized. 11:51:51 INFO - Running cycle 1/1 for kraken test... 11:51:51 INFO - TEST-INFO | started process 28288 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpecRAnN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:52:03 INFO - PROCESS | 28288 | RSS: Main: 151298048 11:52:03 INFO - PROCESS | 28288 | 11:52:05 INFO - PROCESS | 28288 | Cycle 1(1): loaded http://localhost:38360/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38360/tests/kraken/driver.html?testName=audio-beat-detection) 11:52:06 INFO - PROCESS | 28288 | RSS: Main: 204857344 11:52:06 INFO - PROCESS | 28288 | 11:52:09 INFO - PROCESS | 28288 | Cycle 1(1): loaded http://localhost:38360/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38360/tests/kraken/driver.html?testName=audio-dft) 11:52:10 INFO - PROCESS | 28288 | RSS: Main: 185540608 11:52:10 INFO - PROCESS | 28288 | 11:52:13 INFO - PROCESS | 28288 | Cycle 1(1): loaded http://localhost:38360/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38360/tests/kraken/driver.html?testName=audio-fft) 11:52:13 INFO - PROCESS | 28288 | RSS: Main: 267853824 11:52:13 INFO - PROCESS | 28288 | 11:52:16 INFO - PROCESS | 28288 | Cycle 1(1): loaded http://localhost:38360/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38360/tests/kraken/driver.html?testName=audio-oscillator) 11:52:16 INFO - PROCESS | 28288 | RSS: Main: 178085888 11:52:16 INFO - PROCESS | 28288 | 11:52:18 INFO - PROCESS | 28288 | Cycle 1(1): loaded http://localhost:38360/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38360/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:52:19 INFO - PROCESS | 28288 | RSS: Main: 181645312 11:52:19 INFO - PROCESS | 28288 | 11:52:22 INFO - PROCESS | 28288 | Cycle 1(1): loaded http://localhost:38360/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38360/tests/kraken/driver.html?testName=imaging-darkroom) 11:52:23 INFO - PROCESS | 28288 | RSS: Main: 220844032 11:52:23 INFO - PROCESS | 28288 | 11:52:26 INFO - PROCESS | 28288 | Cycle 1(1): loaded http://localhost:38360/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38360/tests/kraken/driver.html?testName=imaging-desaturate) 11:52:27 INFO - PROCESS | 28288 | RSS: Main: 221081600 11:52:27 INFO - PROCESS | 28288 | 11:52:30 INFO - PROCESS | 28288 | Cycle 1(1): loaded http://localhost:38360/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38360/tests/kraken/driver.html?testName=json-parse-financial) 11:52:30 INFO - PROCESS | 28288 | RSS: Main: 219873280 11:52:30 INFO - PROCESS | 28288 | 11:52:32 INFO - PROCESS | 28288 | Cycle 1(1): loaded http://localhost:38360/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38360/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:52:33 INFO - PROCESS | 28288 | RSS: Main: 182370304 11:52:33 INFO - PROCESS | 28288 | 11:52:34 INFO - PROCESS | 28288 | Cycle 1(1): loaded http://localhost:38360/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38360/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:52:35 INFO - PROCESS | 28288 | RSS: Main: 190234624 11:52:35 INFO - PROCESS | 28288 | 11:52:37 INFO - PROCESS | 28288 | Cycle 1(1): loaded http://localhost:38360/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38360/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:52:38 INFO - PROCESS | 28288 | RSS: Main: 197668864 11:52:38 INFO - PROCESS | 28288 | 11:52:41 INFO - PROCESS | 28288 | Cycle 1(1): loaded http://localhost:38360/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38360/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:52:41 INFO - PROCESS | 28288 | RSS: Main: 207380480 11:52:41 INFO - PROCESS | 28288 | 11:52:44 INFO - PROCESS | 28288 | Cycle 1(1): loaded http://localhost:38360/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38360/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:52:45 INFO - PROCESS | 28288 | RSS: Main: 203603968 11:52:45 INFO - PROCESS | 28288 | 11:52:47 INFO - PROCESS | 28288 | Cycle 1(1): loaded http://localhost:38360/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38360/tests/kraken/driver.html?testName=ai-astar) 11:52:47 INFO - PROCESS | 28288 | RSS: Main: 254976000 11:52:47 INFO - PROCESS | 28288 | 11:52:47 INFO - PROCESS | 28288 | __start_tp_report 11:52:47 INFO - PROCESS | 28288 | _x_x_mozilla_page_load 11:52:47 INFO - PROCESS | 28288 | _x_x_mozilla_page_load_details 11:52:47 INFO - PROCESS | 28288 | |i|pagename|runs| 11:52:47 INFO - PROCESS | 28288 | |0;ai-astar;113;117;114;116;118;114;114;115;114;114 11:52:47 INFO - PROCESS | 28288 | |1;audio-beat-detection;154;127;125;167;129;126;127;126;150;127 11:52:47 INFO - PROCESS | 28288 | |2;audio-dft;161;163;161;164;162;163;163;163;161;162 11:52:47 INFO - PROCESS | 28288 | |3;audio-fft;76;76;76;112;76;79;76;76;98;76 11:52:47 INFO - PROCESS | 28288 | |4;audio-oscillator;85;85;117;86;86;86;104;86;85;111 11:52:47 INFO - PROCESS | 28288 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 11:52:47 INFO - PROCESS | 28288 | |6;imaging-darkroom;148;150;150;148;150;150;149;150;149;149 11:52:47 INFO - PROCESS | 28288 | |7;imaging-desaturate;95;96;96;95;96;95;95;96;96;95 11:52:47 INFO - PROCESS | 28288 | |8;json-parse-financial;59;60;59;57;58;58;59;58;58;58 11:52:47 INFO - PROCESS | 28288 | |9;json-stringify-tinderbox;68;68;67;67;67;68;67;68;69;68 11:52:47 INFO - PROCESS | 28288 | |10;stanford-crypto-aes;85;85;84;85;85;86;85;85;84;84 11:52:47 INFO - PROCESS | 28288 | |11;stanford-crypto-ccm;134;138;132;133;137;132;141;143;176;136 11:52:47 INFO - PROCESS | 28288 | |12;stanford-crypto-pbkdf2;180;176;175;185;180;176;175;176;175;175 11:52:47 INFO - PROCESS | 28288 | |13;stanford-crypto-sha256-iterative;75;68;68;69;69;68;67;68;68;68 11:52:47 INFO - PROCESS | 28288 | __end_tp_report 11:52:47 INFO - PROCESS | 28288 | __start_cc_report 11:52:47 INFO - PROCESS | 28288 | _x_x_mozilla_cycle_collect,1813 11:52:47 INFO - PROCESS | 28288 | __end_cc_report 11:52:47 INFO - PROCESS | 28288 | __startTimestamp1483386767572__endTimestamp 11:52:47 INFO - PROCESS | 28288 | 11:52:47 INFO - PROCESS | 28288 | ------- Summary: start ------- 11:52:47 INFO - PROCESS | 28288 | Number of tests: 14 11:52:47 INFO - PROCESS | 28288 | 11:52:47 INFO - PROCESS | 28288 | [#0] ai-astar Cycles:10 Average:114.90 Median:114.50 stddev:1.60 (1.4%) stddev-sans-first:1.54 11:52:47 INFO - PROCESS | 28288 | Values: 113.0 117.0 114.0 116.0 118.0 114.0 114.0 115.0 114.0 114.0 11:52:47 INFO - PROCESS | 28288 | 11:52:47 INFO - PROCESS | 28288 | [#1] audio-beat-detection Cycles:10 Average:135.80 Median:128.00 stddev:15.25 (11.9%) stddev-sans-first:14.69 11:52:47 INFO - PROCESS | 28288 | Values: 154.0 127.0 125.0 167.0 129.0 126.0 127.0 126.0 150.0 127.0 11:52:47 INFO - PROCESS | 28288 | 11:52:47 INFO - PROCESS | 28288 | [#2] audio-dft Cycles:10 Average:162.30 Median:163.00 stddev:1.06 (0.6%) stddev-sans-first:1.01 11:52:47 INFO - PROCESS | 28288 | Values: 161.0 163.0 161.0 164.0 162.0 163.0 163.0 163.0 161.0 162.0 11:52:47 INFO - PROCESS | 28288 | 11:52:47 INFO - PROCESS | 28288 | [#3] audio-fft Cycles:10 Average:82.10 Median:76.00 stddev:12.55 (16.5%) stddev-sans-first:13.11 11:52:47 INFO - PROCESS | 28288 | Values: 76.0 76.0 76.0 112.0 76.0 79.0 76.0 76.0 98.0 76.0 11:52:47 INFO - PROCESS | 28288 | 11:52:47 INFO - PROCESS | 28288 | [#4] audio-oscillator Cycles:10 Average:93.10 Median:85.50 stddev:12.51 (14.6%) stddev-sans-first:12.92 11:52:47 INFO - PROCESS | 28288 | Values: 85.0 85.0 117.0 86.0 86.0 86.0 104.0 86.0 85.0 111.0 11:52:47 INFO - PROCESS | 28288 | 11:52:47 INFO - PROCESS | 28288 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 11:52:47 INFO - PROCESS | 28288 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 11:52:47 INFO - PROCESS | 28288 | 11:52:47 INFO - PROCESS | 28288 | [#6] imaging-darkroom Cycles:10 Average:149.30 Median:150.00 stddev:0.82 (0.5%) stddev-sans-first:0.73 11:52:47 INFO - PROCESS | 28288 | Values: 148.0 150.0 150.0 148.0 150.0 150.0 149.0 150.0 149.0 149.0 11:52:47 INFO - PROCESS | 28288 | 11:52:47 INFO - PROCESS | 28288 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 11:52:47 INFO - PROCESS | 28288 | Values: 95.0 96.0 96.0 95.0 96.0 95.0 95.0 96.0 96.0 95.0 11:52:47 INFO - PROCESS | 28288 | 11:52:47 INFO - PROCESS | 28288 | [#8] json-parse-financial Cycles:10 Average:58.40 Median:58.50 stddev:0.84 (1.4%) stddev-sans-first:0.87 11:52:47 INFO - PROCESS | 28288 | Values: 59.0 60.0 59.0 57.0 58.0 58.0 59.0 58.0 58.0 58.0 11:52:47 INFO - PROCESS | 28288 | 11:52:47 INFO - PROCESS | 28288 | [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:68.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 11:52:47 INFO - PROCESS | 28288 | Values: 68.0 68.0 67.0 67.0 67.0 68.0 67.0 68.0 69.0 68.0 11:52:47 INFO - PROCESS | 28288 | 11:52:47 INFO - PROCESS | 28288 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:85.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 11:52:47 INFO - PROCESS | 28288 | Values: 85.0 85.0 84.0 85.0 85.0 86.0 85.0 85.0 84.0 84.0 11:52:47 INFO - PROCESS | 28288 | 11:52:47 INFO - PROCESS | 28288 | [#11] stanford-crypto-ccm Cycles:10 Average:140.20 Median:137.50 stddev:13.11 (9.5%) stddev-sans-first:13.72 11:52:47 INFO - PROCESS | 28288 | Values: 134.0 138.0 132.0 133.0 137.0 132.0 141.0 143.0 176.0 136.0 11:52:47 INFO - PROCESS | 28288 | 11:52:47 INFO - PROCESS | 28288 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.30 Median:176.00 stddev:3.33 (1.9%) stddev-sans-first:3.39 11:52:47 INFO - PROCESS | 28288 | Values: 180.0 176.0 175.0 185.0 180.0 176.0 175.0 176.0 175.0 175.0 11:52:47 INFO - PROCESS | 28288 | 11:52:47 INFO - PROCESS | 28288 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:68.00 stddev:2.25 (3.3%) stddev-sans-first:0.60 11:52:47 INFO - PROCESS | 28288 | Values: 75.0 68.0 68.0 69.0 69.0 68.0 67.0 68.0 68.0 68.0 11:52:47 INFO - PROCESS | 28288 | -------- Summary: end -------- 11:52:47 INFO - PROCESS | 28288 | 11:52:48 INFO - TEST-INFO | 28288: exit 0 11:52:48 INFO - TEST-OK | kraken | took 63875ms 11:52:48 INFO - SUITE-END | took 1185s 11:52:49 INFO - Completed test suite (00:19:45) 11:52:49 INFO - javascript benchmark 11:52:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2563.3976015636326, 2577.987110064452, 2606.1139212667695, 2611.9477610447793, 2612.6864776226844, 4688.413948256468, 4746.857594272169, 4757.6193904487645, 4758.952410475894, 4774.498677638846, 4734.928976065353, 4773.832915847946, 4809.182438985372, 4816.109019831334, 4865.172920603497, 4322.762248076347, 4343.087951530167, 4383.232934236512, 4422.933655995163, 4481.2381895077915, 4010.6791456683395, 4343.19650864591, 4395.956040439587, 4425.513193548707, 4465.040016396474, 4235.0682849773, 4256.255155347832, 4373.846915357947, 4385.232584297735, 4461.219286624844, 4299.312110062407, 4314.201872653538, 4315.050688848449, 4315.525292217853, 4316.223079845627, 4253.21315556623, 4299.204647140289, 4301.182775272689, 4301.827926882921, 4306.569343065668, 4687.906241875144, 4692.483826779086, 4718.528147185289, 4742.928856067162, 4835.782389792468, 5082.1360368737405, 5088.720120393377, 5093.439721630654, 5132.897342053138, 5135.589152867761, 5121.641485096045, 5130.127878260705, 5133.820316288912, 5136.8202112925865, 5181.792728290864, 4735.715857048588, 4738.905221895543, 4773.641976851715, 4782.139214941274, 4784.760761961888, 5164.509371609691, 5209.583233341324, 5221.399539052982, 5253.763580638881, 5310.389305229871, 4963.60291176705, 4999.450060493343, 5014.648974571818, 5019.949800502021, 5061.164907790173, 4984.3021976923255, 5046.142155833517, 5108.055009823194, 5109.642325037212, 5113.53978141969, 4945.727984960861, 5032.672876263031, 5076.035553244946, 5100.336956195671, 5164.638475306692, 5096.464871188546, 5112.513228041507, 5112.795488180505, 5113.718745469035, 5114.641975061784, 4287.8070486828165, 4287.892802679896, 4290.034742183047, 4321.351797230441, 4332.155229730172, 3598.3163198992106, 3609.205974685565, 3657.9451308230396, 3684.8341824617955, 3692.981535092361, 4427.623651989553, 4428.844990425319, 4432.113577284556, 4463.955360446354, 4468.195724769573, 5142.280080788692, 5153.742312884341, 5159.793608255628, 5162.561182299547, 5206.245094461282, 4333.068390296038, 4365.192439398721, 4370.8033138508845, 4419.40338054365, 4425.734455932655, 4518.819247230074, 4568.520305367955, 4574.405327307495, 4579.06129243511, 4602.861914142581, 4804.303376010529, 4806.158922188673, 4806.375171227718, 4807.735574543433, 4861.611071114373, 4947.0, 4950.356453661145, 5121.206213036985, 5124.154514505065, 5160.509751573594, 4788.377510923558, 4791.377120974251, 4806.975965120152, 4854.0, 4896.706197628154, 5056.241563765465, 5057.7724002419245, 5060.544550990428, 5063.3417655704525, 5106.923396149135, 4893.951060489492, 5116.565091967224, 5135.075686376488, 5137.306463627362, 5139.794408223779, 4708.034852855088, 4873.025394921101, 4905.926411103907, 4908.705477671351, 4984.551390374883, 4927.704337739747, 4936.185529387754, 4937.9012419752125, 4938.160512712776, 4980.203167493184, 4617.538246175355, 4634.351190833218, 4642.883927901695, 4700.858974230779, 4872.634552408655, 4751.073540659539, 4782.163121453801, 4788.521147885183, 4791.5687588117235, 4800.807967681254, 4636.44362676481, 4694.037722266995, 4695.295705644044, 4700.811967521261, 4703.3885594872445], "value": 4644.5394295464785, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [536.5332161019913, 558.1850498272524, 566.6260268222971, 567.3843879390861, 583.7198144890455, 36194.638053619456, 38295.23409531811, 38528.03679908, 42575.78712106443, 42598.57401425985, 38965.415518767244, 39330.60669393305, 39374.21251574974, 39413.21173576527, 39437.21125577487, 7366.079240094989, 7544.735934242302, 7638.045244344471, 7835.451518393715, 7837.647305871249, 10027.448490333029, 10355.534000969974, 10360.378377297386, 10374.0, 10374.792504149913, 10068.14420774235, 10128.0, 10141.0, 10144.239182061337, 10147.188224941987, 10068.848967265498, 10100.898991010106, 10105.444200568965, 10128.240381971307, 10138.138258247984, 9920.95039524805, 9999.400035997864, 10001.0, 10001.699949001542, 10003.949980250125, 37540.249195015946, 37920.62079379198, 38047.619523804686, 38047.809760951015, 38070.80964595187, 3706.3143318485895, 3786.1291902862495, 3803.391457366808, 3818.4845045918723, 3833.099221682902, 28242.29394265139, 28376.574351384745, 28435.715642843512, 28602.0, 29284.803639727106, 3329.9833500832583, 3408.5398471206317, 3469.3061387722555, 3551.0944709099012, 3563.2160924596546, 230200.0, 231887.0, 232012.0, 232274.0, 232469.0, 47430.28854567184, 47924.52075479201, 47934.520654793705, 47938.280925786145, 48009.5199048012, 49070.75464622654, 49151.508484914695, 49219.031238750045, 49232.0, 49255.50744492509, 13133.671658208621, 13355.0, 13362.398692058881, 13363.198208107351, 13364.866351336557, 7528.548287102792, 7667.808304792313, 9420.62317507292, 10056.29605927578, 10250.487475626338, 15696.76454853178, 15746.763798542803, 15754.9212253938, 15781.132037738034, 15816.92091539558, 6327.272363678144, 6329.303776584572, 6459.644719540376, 6470.2559205691, 6648.933510664928, 787.8542469643135, 793.8729803231455, 819.7335865843625, 821.8233079887733, 839.139881621343, 26478.470430591282, 27375.315617109733, 28037.616802571603, 28047.298817529725, 28048.85975570109, 969.1229437359201, 972.6595691507915, 976.4629453800381, 984.9556769945369, 985.8373368394278, 13584.388702508213, 14483.275836208148, 14716.705665886837, 14870.776938345933, 14930.10419374841, 345541.0, 347176.0, 347329.0, 347373.0, 348072.0, 47683.0, 48369.0, 48387.887029602876, 48409.5159048412, 48471.75764121157, 1193.40926241511, 1198.2725311917588, 1232.9198602090835, 1236.9876301237232, 1246.214884622682, 25370.873145634152, 26421.73578264193, 26652.20043398701, 26923.730762692907, 27071.1878643641, 40868.386974194815, 41375.7931210342, 41475.0, 41563.37654935239, 41614.58385416107, 220561.0, 223139.0, 223331.0, 223582.0, 224226.0, 22533.774662253825, 23114.537709245385, 24100.75899240985, 24985.625215622145, 25198.0, 40036.39945400763, 40112.59887401089, 40324.79837600793, 40609.79695101624, 40629.39055914223, 33726.0, 34477.82761086179, 34743.0, 34875.47686784751, 35469.82265088658, 33940.15149621279, 34467.482987755706, 34468.31063378769, 34599.82700086483, 34722.47916281207, 32989.0, 33175.50236746499, 33234.16914577155, 33639.66360336365, 33907.321853563284, 28907.429083754305, 31235.37529249448, 31317.373652527276, 31340.216494587818, 31500.695528177872, 23696.28911132669, 23786.286411406993, 23891.402714932265, 24326.0, 24377.26868193957], "value": 17204.573942148993, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.9371913055649, 360.5331096230383, 368.23039846720354, 375.6074901727694, 392.68585131894497, 12632.0, 15613.0, 15718.0, 16602.169891505437, 16745.497635070966, 16709.66580668389, 16719.749203761952, 16743.83256167438, 16863.40978065768, 16865.578360540992, 4944.703317800934, 5164.277001219813, 5170.922436163461, 5375.973120134394, 5439.564834813205, 3650.142216579102, 5442.156465747816, 5477.890442191154, 5486.588505862056, 5488.69812160331, 3811.1424929390805, 6598.736050557972, 6870.931290687104, 6893.896591551131, 6895.448364130857, 6665.533412661116, 6666.266710661824, 6755.223149337815, 6862.627474505119, 6890.0, 6603.108580341641, 6667.766298290078, 6672.199336079701, 6677.265500794909, 6679.165104361955, 21695.0, 21874.125034998582, 21973.450663733376, 22188.334349969526, 22201.44496387587, 2190.2772085212, 2300.298408985259, 2352.8588284702973, 2394.353524548362, 2397.724261709908, 13446.193228406328, 13512.797308040388, 13682.179069255777, 13767.242801645905, 14194.716105677828, 1824.1608859924452, 1861.1159699142934, 1873.297513432463, 1880.7272945422974, 1918.4628304074881, 54409.45590544123, 64332.67833660802, 66113.33886661168, 70384.29615703829, 71979.0, 15317.23413829304, 15344.693106137815, 15611.843881561266, 15917.840821591635, 15919.442819501493, 26453.47093058128, 26514.734852651225, 26544.734552654227, 26598.335041623726, 26742.0, 8336.541490218096, 8456.746297611082, 8491.872621910676, 8550.444221125606, 8644.308455323559, 6972.546784458994, 7011.439084873198, 7156.892646610305, 7163.283671632899, 7190.137183538009, 7933.286004259644, 8079.434439589172, 8083.595820208966, 8117.0, 8154.5536339098035, 3299.736021118305, 3327.73378129749, 3385.153711572107, 3385.3398587275738, 3396.7961922284744, 749.7375918428506, 773.524282566229, 777.4014009212988, 793.0998316910349, 793.9757712550745, 14196.432142714175, 14950.62623434401, 15230.847691523164, 15677.608059798367, 16021.919890400706, 775.693601027591, 776.1346099099576, 781.620913856779, 791.189031242969, 792.2343189164585, 8574.969764210811, 8662.913370866338, 8885.466871987572, 8941.329400295004, 9138.725838224864, 291945.0, 296760.0, 296969.0, 297344.2124630024, 298021.0, 69242.72951340137, 69359.65320173367, 70515.29484705087, 70925.2907470929, 72981.6350918242, 879.9560021998874, 896.171041786345, 915.1306259053925, 918.3433844801, 927.4435338796668, 13803.0, 13818.447262109403, 13922.860771392561, 13925.860741392456, 14382.424703011762, 27282.590761138996, 34289.314213715086, 35349.82325088358, 36302.636973629924, 36334.636653633126, 41703.58296416997, 43995.0, 45875.0, 47866.760666196446, 50949.49050509596, 7490.475666703279, 7610.429217808576, 7615.753352760838, 7661.272179142972, 7880.0, 9177.449353038839, 11273.774524509628, 11465.713357166138, 11918.821217681914, 11993.760124797629, 5242.580593552583, 9593.232541396812, 10170.796584068425, 10225.43760093202, 10535.683929482127, 9611.855822162814, 9637.42175469474, 9863.731341791285, 10007.0, 10404.167666586503, 9527.904720952702, 9786.951065244628, 9868.506574671093, 9883.802323953338, 10117.494125293559, 7107.182673992557, 7545.170031296443, 7574.394048475999, 7754.302112809874, 7779.210781520169, 8987.685431009882, 9253.907460925304, 9449.858252126362, 9497.905020949978, 9558.85661715061], "value": 8734.767369029432, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1306.4055854586163, 1316.6247619428466, 1329.2954733990985, 1330.0357241000277, 1331.4008696086764, 6960.164780226367, 7371.852562948745, 7376.4098872090235, 7381.557106573596, 7394.778156655302, 6527.477801775858, 6753.324667533244, 7095.6806943687525, 7274.563526188419, 7307.744228951974, 2154.439845640133, 2192.6491761318193, 2196.846220764547, 2198.7251593550805, 2200.2299195281603, 2137.668661357492, 2187.3437968609433, 2192.9890350548303, 2197.044285735702, 2202.1411649456722, 1828.5794267318524, 1888.037101078446, 2039.9184032638677, 2105.0632468551503, 2151.9031643576077, 2146.8711877287333, 2164.0910817456706, 2165.935021949344, 2166.360923527563, 2167.9241226556996, 2138.967915481269, 2144.8820314882673, 2148.9247876324253, 2163.9242626508, 2165.2962787094257, 7078.610676412795, 7224.67488962998, 7236.746713865042, 7237.674304656303, 7238.27617238272, 4458.152950939311, 4593.724376537419, 4595.241785105453, 4596.241620132674, 4597.770111494446, 2853.2296280004284, 2952.099609619065, 3034.044276053058, 3042.5131978883273, 3055.5874956880757, 1066.7333166708322, 1115.6318414923137, 1132.0999805154922, 1167.5504930601694, 1187.4300335838846, 9761.07269809367, 9801.411915285105, 9804.509774511245, 9806.16647584949, 9818.803623927553, 3975.8012099394914, 4211.389348544444, 4275.102228532043, 4298.78506074695, 4307.956920430818, 8466.0, 8476.703315383931, 8479.830403391898, 8482.618282177316, 8483.321334293241, 4644.95355046452, 4645.512221216723, 4647.256438969748, 4650.209464390994, 4656.348111264426, 3630.5098811660087, 3641.8361173747244, 4073.4704488416314, 4255.297875850512, 4266.274733295348, 3485.546878905726, 3507.9649203508147, 3582.7671201371827, 3587.5336206293014, 3612.458131280329, 1176.129664048598, 1216.5255550335376, 1219.1222319929814, 1221.8900298973135, 1229.538922903911, 791.2364568191723, 814.6578437056451, 836.4228682209256, 836.4604829884812, 851.2891735400885, 4798.424189097331, 4881.585065269421, 4901.166801643729, 5008.1486147355035, 5139.7687104080405, 872.7032808845023, 908.8500397434482, 921.6909560313777, 930.6412637549254, 935.2845073518764, 3426.9657303427143, 3434.175797808508, 3456.1186897341017, 3496.3182179474757, 3542.167590616203, 8756.649734010696, 8923.419977701558, 8986.19124278818, 9002.459852408876, 9005.324600654978, 8963.148500892405, 8978.191962723386, 8980.281577473917, 8982.775430614287, 8986.415882967585, 6582.243042050225, 6736.7642132525125, 6838.179418469816, 6966.512344135862, 6968.825779355557, 4687.906241875212, 4900.754962251945, 4961.305417241517, 5050.98980203968, 5104.897902042013, 7931.510522709026, 8174.223448772357, 8207.466514676527, 8218.958905205674, 8274.875876861732, 7481.812954676177, 8269.04905935801, 8350.916490835014, 8367.623456944573, 8368.330533557422, 5910.911336330045, 6096.939030609815, 6419.582727122722, 6594.208694956636, 6625.50308726857, 6866.176058872968, 6998.790036298919, 7047.647617619201, 7220.422366210795, 7235.529690570096, 6394.392532709385, 6438.3883531064475, 6442.162518872517, 6588.670566471753, 6660.600363978177, 6270.623762574261, 6274.090256912813, 6291.874162516816, 6302.243730752339, 6329.873402531832, 5650.039493286069, 5772.740226689725, 5789.623674461147, 5790.913136302875, 5796.159556864147, 4259.574042595716, 4398.4165700348485, 4435.024294655171, 4470.552944705503, 4473.619742321939, 4263.680223983276, 4275.059486912998, 4323.200207961537, 4337.15425492026, 4372.060007098489], "value": 3991.890146019863, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.98947031589046, 352.9929401411972, 355.25928439204256, 360.19496425489046, 363.95450568678916, 4796.953934251749, 4810.374651295331, 4819.277108433736, 4845.418549774032, 4854.878628034301, 4777.570018698317, 4779.115863565243, 4789.473157952622, 4801.927971080428, 4814.325994360793, 3674.816259187043, 3775.5469343678797, 3781.7163712721517, 3839.0, 3873.98063009686, 3853.5761066282685, 3863.6715879150306, 3867.3425517662067, 3879.5926427724967, 3882.165334453092, 3835.0, 3842.884713458601, 3848.018270590648, 3848.6536211740936, 3854.036490877281, 3679.8896033118917, 3694.5935947046073, 3792.0, 3809.904752381213, 3811.9618803811886, 3450.258194488197, 3453.4474484082675, 3459.0487615905577, 3464.683420300295, 3472.58329000519, 4673.158831410345, 4682.227432473638, 4696.976515117402, 4701.0, 4706.670533062687, 4034.7377420467574, 4208.705390622657, 4367.432233809616, 4373.234683930331, 4384.868453946387, 4948.604111671058, 4961.305417241589, 4973.3286006389035, 4978.77595508203, 4980.601551875841, 3550.715942724576, 3556.199855032623, 3564.946525802115, 3571.5178450909057, 3578.570571531433, 5006.849794506098, 5145.459726728677, 5158.246196293241, 5179.585633149339, 5221.190715439113, 3625.8549658013912, 3636.1818590816856, 3638.1632224588493, 3659.597444281127, 3662.1393972416463, 3672.6510981456718, 3683.778973261613, 3686.502322186524, 3696.4085746280466, 3706.8517259309865, 4180.853670121531, 4187.099773548702, 4193.412922190896, 4207.8316867325575, 4208.473940757405, 4810.759462026885, 4939.0, 4945.9258111128365, 4959.479254678279, 4968.826091086795, 1233.5065973610629, 1235.3329202230875, 1235.5799028330412, 1238.7089034076985, 1238.7089034077164, 821.93013593844, 859.8882145321194, 862.7886167888907, 864.7319331007408, 870.4342177584494, 4186.372044193396, 4262.936055959163, 4306.707987603706, 4349.998501034276, 4390.09031071485, 5139.794408223629, 5142.717150556755, 5152.098382783073, 5158.6131040171385, 5162.199859021857, 4378.5183629800695, 4417.911641767211, 4421.668374871898, 4426.44669416323, 4435.489918659331, 2557.9104731334314, 2642.5507663697217, 2649.576067829138, 2670.8531030793492, 2692.9192124236306, 4670.1827180244, 4671.6262698984, 4692.7653617319, 4770.236762118045, 4790.640701947368, 5028.949710502921, 5035.571976381975, 5049.6212784041345, 5072.695638261716, 5074.847754567369, 4449.221386257392, 4659.930101048487, 4727.456342520654, 4735.33705281254, 4744.264638980894, 4976.701397916137, 4991.5258050485145, 4994.127202299138, 4997.175466048061, 5020.774065167003, 4868.488808675038, 4868.48880867518, 4898.2652602109965, 4914.827981020647, 4933.235348520985, 4571.748553829571, 4825.879353016203, 4884.902301954012, 4891.95108048915, 4893.412790465167, 3688.815559222082, 3692.5015122958057, 3694.3719567674098, 3713.6472035156617, 3716.256748650335, 5137.126688463045, 5137.8201762938115, 5146.4338922717725, 5148.7425628717665, 5170.586353091819, 4789.760511974457, 4885.193942999365, 4915.361003069578, 4923.532264434873, 4935.827246046371, 4898.412190537016, 4920.21276595743, 4948.257761335828, 4953.306537084739, 4953.529414705597, 4879.780409881635, 4885.609151267819, 4891.926621100615, 4900.975495122644, 4912.6561140719805, 4729.55069268419, 4824.927626085541, 4856.708597484162, 4910.0, 4948.1835497142565, 4718.655183272751, 4838.0, 4841.2496063110275, 4842.4673285939225, 4845.53967373099], "value": 3773.5819903669967, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [664.9667516624168, 683.2040672616399, 738.9741359052432, 739.2127384335682, 747.0960138232738, 12662.810057849128, 13554.322283885804, 13563.389647465863, 13574.728505429886, 13609.863901360983, 12740.235585864832, 12805.487780488793, 12818.0, 12838.679033024178, 12916.677083072927, 669.2337273821471, 688.703857341343, 789.6999140326697, 791.0428381658201, 812.5815205169342, 822.8642274024779, 828.6105530400702, 828.8052307707684, 829.050736906242, 829.402829962426, 866.7919699272161, 869.0961400143843, 869.1525762381691, 869.2481003931586, 869.2654706772798, 690.6615758278458, 711.0187940641881, 711.2745000099869, 714.9392301654366, 865.3380164174412, 609.5306613907267, 630.1461519640912, 635.8823617630753, 636.723025483916, 636.9936300636981, 12895.935520322431, 12912.354382280848, 12923.547675831302, 12925.224486530744, 12926.87073129266, 12081.708375307995, 12208.206466579644, 12281.324527151002, 12328.568500102454, 12440.129190956637, 11443.141764367623, 11452.484638191301, 11481.540738370455, 11501.942490287494, 12055.93972030143, 4056.7565946043333, 4074.670709750797, 4119.176164767028, 4141.213169497786, 4146.751194928314, 56394.154087688716, 57056.714716426155, 57325.0, 57931.71034144802, 59786.402135978955, 9465.479398633004, 9698.563564639608, 9898.554565044591, 9916.603335866484, 9918.40489570628, 18492.630147396976, 18601.162947667388, 18643.0, 18676.34632787846, 18765.24939002452, 5914.940850591525, 5980.850478738066, 6066.211392519032, 6102.755889764359, 6128.63228206309, 3316.369889720945, 3421.298633780069, 3438.8796392126155, 3441.8107004114513, 3451.9654803452145, 2652.204338698383, 2717.823341482837, 2727.8090533662453, 2728.3451971526692, 2730.494858451193, 444.06967403290054, 450.1626973828676, 450.16719069720756, 455.98404055857884, 457.00601192406384, 578.4938179093293, 601.8375038739516, 603.9426254505815, 604.3714536881594, 608.9878202436015, 7849.764507064683, 7863.719521338748, 8014.270623642263, 8135.918640813635, 8160.428769986044, 563.194631676698, 578.2858170159849, 598.5989387110646, 602.2923065398227, 613.8772245550819, 3759.6259216835465, 3930.606939306104, 3950.6839452843706, 3985.342418500973, 4029.576894426043, 53596.0, 54100.0, 63307.6834615824, 64277.0, 65149.348506514325, 53856.46143538514, 54363.45636543663, 54505.0, 55492.445075549535, 55867.720661397245, 40928.79535602303, 51896.0, 52101.478985209666, 52153.7392313036, 53247.467525325024, 7323.8535229296185, 7616.809579760328, 7728.998151718134, 7796.220377962159, 7808.882866757117, 36370.09074773152, 36532.0, 36677.63322366742, 36892.26215475729, 37970.240595188494, 42466.15067698567, 44489.0, 44848.0, 45382.54617453915, 46835.53164468312, 9702.320837541305, 9750.951245243728, 9821.705348839547, 9846.212303015885, 10095.0, 10552.419616921143, 10770.623028193975, 10802.837957430487, 10812.513436895515, 10881.401522916, 9438.811223775623, 9509.286803489627, 9823.459709716035, 10047.74880627961, 10257.33327333721, 9747.0, 10285.177185825265, 10373.844392333971, 10457.320274182153, 10701.678949631523, 9692.22462203008, 9928.851067234142, 10161.085502304828, 10255.794884102426, 10279.53742081623, 8102.837943240984, 8515.701950431705, 8657.350698697497, 8669.133086691281, 9070.863937040818, 8260.421770476249, 8622.525761083201, 8629.26651234627, 8682.869756953776, 8786.516741579018], "value": 6019.274131700427, "unit": "score"}], "name": "dromaeo_css", "value": 6312.882245018695, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 117.0, 114.0, 116.0, 118.0, 114.0, 114.0, 115.0, 114.0, 114.0], "value": 114.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 127.0, 125.0, 167.0, 129.0, 126.0, 127.0, 126.0, 150.0, 127.0], "value": 135.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 161.0, 164.0, 162.0, 163.0, 163.0, 163.0, 161.0, 162.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 112.0, 76.0, 79.0, 76.0, 76.0, 98.0, 76.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 117.0, 86.0, 86.0, 86.0, 104.0, 86.0, 85.0, 111.0], "value": 93.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 150.0, 150.0, 148.0, 150.0, 150.0, 149.0, 150.0, 149.0, 149.0], "value": 149.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 57.0, 58.0, 58.0, 59.0, 58.0, 58.0, 58.0], "value": 58.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 67.0, 67.0, 67.0, 68.0, 67.0, 68.0, 69.0, 68.0], "value": 67.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 85.0, 85.0, 86.0, 85.0, 85.0, 84.0, 84.0], "value": 84.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 138.0, 132.0, 133.0, 137.0, 132.0, 141.0, 143.0, 176.0, 136.0], "value": 140.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 176.0, 175.0, 185.0, 180.0, 176.0, 175.0, 176.0, 175.0, 175.0], "value": 177.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 68.0, 68.0, 69.0, 69.0, 68.0, 67.0, 68.0, 68.0, 68.0], "value": 68.8, "unit": "score"}], "name": "kraken", "value": 1547.1999999999998, "alertThreshold": 2.0}]} 11:52:49 INFO - Return code: 0 11:52:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:52:49 INFO - # TBPL SUCCESS # 11:52:49 INFO - Running post-action listener: _resource_record_post_action 11:52:49 INFO - [mozharness: 2017-01-02 19:52:49.373939Z] Finished run-tests step (success) 11:52:49 INFO - Running post-run listener: _resource_record_post_run 11:52:49 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 399024128; Read time: 8; Write time: 562260 11:52:49 INFO - TinderboxPrint: CPU usage
13.1% 11:52:49 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 11:52:49 INFO - TinderboxPrint: I/O write bytes / time
399,024,128 / 562,260 11:52:49 INFO - TinderboxPrint: CPU idle
8,336.2 (86.9%) 11:52:49 INFO - TinderboxPrint: CPU user
1,210.2 (12.6%) 11:52:49 INFO - TinderboxPrint: Swap in / out
0 / 0 11:52:49 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99336192; Read time: 0; Write time: 180160 11:52:49 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 282296320; Read time: 0; Write time: 371892 11:52:50 INFO - Running post-run listener: _upload_blobber_files 11:52:50 INFO - Blob upload gear active. 11:52:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:52:50 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 11:52:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:52:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:52:50 INFO - (blobuploader) - INFO - Open directory for files ... 11:52:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:52:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:52:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:52:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:52:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:52:53 INFO - (blobuploader) - INFO - Done attempting. 11:52:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:52:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:52:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:52:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:52:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:52:54 INFO - (blobuploader) - INFO - Done attempting. 11:52:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:52:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:52:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:52:55 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:52:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:52:55 INFO - (blobuploader) - INFO - Done attempting. 11:52:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:52:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:52:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:52:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:52:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:52:56 INFO - (blobuploader) - INFO - Done attempting. 11:52:56 INFO - (blobuploader) - INFO - Iteration through files over. 11:52:56 INFO - Return code: 0 11:52:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:52:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:52:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2d1572461b4f17ece2f648a2efc7b99d6b69084596fba2cf99db69d887cb5ddb2d4c5ed4cb7b9e7bff399301529fffd95f04abd07c011ee40477b8bd502f722b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9e41ab32d7cd9a15afa7b5e76c6299f827892a0b71baba82ec528ec14df74433fe7cab65d858efa7071cd8e7ab79fa26818e55b803c9fd289e2f4e4418ddba87", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/09dfa3ac348045abfcb93bbf54185fa9a379ad132940e20fbc650fe0a6683fd48a079e1d09742960f8d088e001b636a973ada6c966f6099af2461242d1120fc5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1dcf10d1e0bdeb748240f2f01faa14aad697fff69bc87a29ca66894c6cf190e0f171050a85d605ed4a143dd4ec69630509c7069be25f2ddc0f3bfca67042affe"} 11:52:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:52:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:52:56 INFO - Contents: 11:52:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2d1572461b4f17ece2f648a2efc7b99d6b69084596fba2cf99db69d887cb5ddb2d4c5ed4cb7b9e7bff399301529fffd95f04abd07c011ee40477b8bd502f722b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9e41ab32d7cd9a15afa7b5e76c6299f827892a0b71baba82ec528ec14df74433fe7cab65d858efa7071cd8e7ab79fa26818e55b803c9fd289e2f4e4418ddba87", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/09dfa3ac348045abfcb93bbf54185fa9a379ad132940e20fbc650fe0a6683fd48a079e1d09742960f8d088e001b636a973ada6c966f6099af2461242d1120fc5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1dcf10d1e0bdeb748240f2f01faa14aad697fff69bc87a29ca66894c6cf190e0f171050a85d605ed4a143dd4ec69630509c7069be25f2ddc0f3bfca67042affe"} 11:52:56 INFO - Running post-run listener: copy_logs_to_upload_dir 11:52:56 INFO - Copying logs to upload dir... 11:52:56 INFO - mkdir: /builds/slave/test/build/upload/logs 11:52:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.454885 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-01-02 11:52:55.673542) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-02 11:52:55.680764) ========= 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=af724c981e2a0f424dbabf99000001e7-1483375803.390749-978377419 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2d1572461b4f17ece2f648a2efc7b99d6b69084596fba2cf99db69d887cb5ddb2d4c5ed4cb7b9e7bff399301529fffd95f04abd07c011ee40477b8bd502f722b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9e41ab32d7cd9a15afa7b5e76c6299f827892a0b71baba82ec528ec14df74433fe7cab65d858efa7071cd8e7ab79fa26818e55b803c9fd289e2f4e4418ddba87", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/09dfa3ac348045abfcb93bbf54185fa9a379ad132940e20fbc650fe0a6683fd48a079e1d09742960f8d088e001b636a973ada6c966f6099af2461242d1120fc5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1dcf10d1e0bdeb748240f2f01faa14aad697fff69bc87a29ca66894c6cf190e0f171050a85d605ed4a143dd4ec69630509c7069be25f2ddc0f3bfca67042affe"} build_url:https://queue.taskcluster.net/v1/task/UC_N8bMsR0CJ34QVha7V_w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011822 build_url: 'https://queue.taskcluster.net/v1/task/UC_N8bMsR0CJ34QVha7V_w/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2d1572461b4f17ece2f648a2efc7b99d6b69084596fba2cf99db69d887cb5ddb2d4c5ed4cb7b9e7bff399301529fffd95f04abd07c011ee40477b8bd502f722b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9e41ab32d7cd9a15afa7b5e76c6299f827892a0b71baba82ec528ec14df74433fe7cab65d858efa7071cd8e7ab79fa26818e55b803c9fd289e2f4e4418ddba87", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/09dfa3ac348045abfcb93bbf54185fa9a379ad132940e20fbc650fe0a6683fd48a079e1d09742960f8d088e001b636a973ada6c966f6099af2461242d1120fc5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1dcf10d1e0bdeb748240f2f01faa14aad697fff69bc87a29ca66894c6cf190e0f171050a85d605ed4a143dd4ec69630509c7069be25f2ddc0f3bfca67042affe"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-02 11:52:55.706365) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 11:52:55.706681) ========= 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=af724c981e2a0f424dbabf99000001e7-1483375803.390749-978377419 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004419 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 11:52:55.791401) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-02 11:52:55.791708) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-02 11:52:55.792036) ========= ========= Total master_lag: 0.17 =========