builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs slave: talos-linux64-ix-036 starttime: 1491455249.01 results: success (0) revision: ec8d1d3db50c85037e8077c32c8403570a5df493 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-05 22:07:29.006711) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-05 22:07:29.007172) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-05 22:07:29.007447) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-05 22:07:29.022286) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 22:07:29.022602) ========= 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=14ef55db36f7623abb31b9cf000001d5-1491455248.489998-1886381097 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-04-05 22:07:29-- 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.4M=0s 2017-04-05 22:07:29 (42.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.101601 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 22:07:29.138066) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 22:07:29.138380) ========= 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=14ef55db36f7623abb31b9cf000001d5-1491455248.489998-1886381097 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019572 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 22:07:29.188567) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 22:07:29.189045) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ec8d1d3db50c85037e8077c32c8403570a5df493 --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 ec8d1d3db50c85037e8077c32c8403570a5df493 --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=14ef55db36f7623abb31b9cf000001d5-1491455248.489998-1886381097 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-04-05 22:07:29,309 truncating revision to first 12 chars 2017-04-05 22:07:29,309 Setting DEBUG logging. 2017-04-05 22:07:29,309 attempt 1/10 2017-04-05 22:07:29,309 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ec8d1d3db50c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-05 22:07:29,747 unpacking tar archive at: mozilla-central-ec8d1d3db50c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.740309 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 22:07:29.940113) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-05 22:07:29.940434) ========= script_repo_revision: ec8d1d3db50c85037e8077c32c8403570a5df493 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-05 22:07:29.940806) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-05 22:07:29.941077) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-05 22:07:29.947586) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-04-05 22:07:29.947871) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=14ef55db36f7623abb31b9cf000001d5-1491455248.489998-1886381097 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:07:30 INFO - MultiFileLogger online at 20170405 22:07:30 in /builds/slave/test 22:07:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 22:07:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:07:30 INFO - {'append_to_log': False, 22:07:30 INFO - 'base_work_dir': '/builds/slave/test', 22:07:30 INFO - 'blob_upload_branch': 'Firefox', 22:07:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:07:30 INFO - 'branch': 'Firefox', 22:07:30 INFO - 'buildbot_json_path': 'buildprops.json', 22:07:30 INFO - 'config_files': ('talos/linux_config.py',), 22:07:30 INFO - 'default_actions': ('clobber', 22:07:30 INFO - 'read-buildbot-config', 22:07:30 INFO - 'download-and-extract', 22:07:30 INFO - 'populate-webroot', 22:07:30 INFO - 'create-virtualenv', 22:07:30 INFO - 'install', 22:07:30 INFO - 'run-tests'), 22:07:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:07:30 INFO - 'download_minidump_stackwalk': True, 22:07:30 INFO - 'download_symbols': 'ondemand', 22:07:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:07:30 INFO - 'tooltool.py': '/tools/tooltool.py', 22:07:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:07:30 INFO - '/tools/misc-python/virtualenv.py')}, 22:07:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:07:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:07:30 INFO - 'gecko_profile': False, 22:07:30 INFO - 'gecko_profile_interval': 0, 22:07:30 INFO - 'installer_path': 'installer.exe', 22:07:30 INFO - 'log_level': 'info', 22:07:30 INFO - 'log_name': 'talos', 22:07:30 INFO - 'log_to_console': True, 22:07:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:07:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:07:30 INFO - 'opt_config_files': (), 22:07:30 INFO - 'pip_index': False, 22:07:30 INFO - 'suite': 'dromaeojs', 22:07:30 INFO - 'system_bits': '32', 22:07:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:07:30 INFO - 'title': 'talos-linux64-ix-036', 22:07:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:07:30 INFO - 'use_talos_json': True, 22:07:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:07:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:07:30 INFO - 'work_dir': 'build'} 22:07:30 INFO - [mozharness: 2017-04-06 05:07:30.165100Z] Running clobber step. 22:07:30 INFO - Running pre-action listener: _resource_record_pre_action 22:07:30 INFO - Running main action method: clobber 22:07:30 INFO - rmtree: /builds/slave/test/build 22:07:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:07:31 INFO - Running post-action listener: _resource_record_post_action 22:07:31 INFO - [mozharness: 2017-04-06 05:07:31.796229Z] Finished clobber step (success) 22:07:31 INFO - [mozharness: 2017-04-06 05:07:31.796328Z] Running read-buildbot-config step. 22:07:31 INFO - Running pre-action listener: _resource_record_pre_action 22:07:31 INFO - Running main action method: read_buildbot_config 22:07:31 INFO - Using buildbot properties: 22:07:31 INFO - { 22:07:31 INFO - "project": "", 22:07:31 INFO - "product": "firefox", 22:07:31 INFO - "who": "philringnalda@gmail.com", 22:07:31 INFO - "installer_path": "public/build/target.tar.bz2", 22:07:31 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs", 22:07:31 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 22:07:31 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs", 22:07:31 INFO - "stage_platform": "linux64-stylo", 22:07:31 INFO - "basedir": "/builds/slave/test", 22:07:31 INFO - "buildnumber": 12, 22:07:31 INFO - "platform": "ubuntu64_hw_stylo", 22:07:31 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:07:31 INFO - "slavebuilddir": "test", 22:07:31 INFO - "taskId": "XKfTqcHpRzuHL4tY8U7YJg", 22:07:31 INFO - "branch": "mozilla-central", 22:07:31 INFO - "script_repo_revision": "production", 22:07:31 INFO - "revision": "ec8d1d3db50c85037e8077c32c8403570a5df493", 22:07:31 INFO - "slavename": "talos-linux64-ix-036", 22:07:31 INFO - "repo_path": "mozilla-central" 22:07:31 INFO - } 22:07:31 INFO - Finding installer, test and symbols from parent task. 22:07:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XKfTqcHpRzuHL4tY8U7YJg'}, attempt #1 22:07:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XKfTqcHpRzuHL4tY8U7YJg'}, attempt #1 22:07:32 INFO - Task dependencies: Vnyo5g2vT3O3SBVrvvZGXA 22:07:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Vnyo5g2vT3O3SBVrvvZGXA'}, attempt #1 22:07:33 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Vnyo5g2vT3O3SBVrvvZGXA/artifacts/public/build/target.tar.bz2 22:07:33 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Vnyo5g2vT3O3SBVrvvZGXA/artifacts/public/build/test_packages.json 22:07:33 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Vnyo5g2vT3O3SBVrvvZGXA/artifacts/public/build/target.crashreporter-symbols.zip 22:07:33 INFO - Running post-action listener: _resource_record_post_action 22:07:33 INFO - [mozharness: 2017-04-06 05:07:33.170501Z] Finished read-buildbot-config step (success) 22:07:33 INFO - [mozharness: 2017-04-06 05:07:33.170721Z] Running download-and-extract step. 22:07:33 INFO - Running pre-action listener: _resource_record_pre_action 22:07:33 INFO - Running main action method: download_and_extract 22:07:33 INFO - mkdir: /builds/slave/test/build/tests 22:07:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:07:33 INFO - trying https://queue.taskcluster.net/v1/task/Vnyo5g2vT3O3SBVrvvZGXA/artifacts/public/build/target.test_packages.json 22:07:33 INFO - Downloading https://queue.taskcluster.net/v1/task/Vnyo5g2vT3O3SBVrvvZGXA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 22:07:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Vnyo5g2vT3O3SBVrvvZGXA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 22:07:33 INFO - Downloaded 986 bytes. 22:07:33 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 22:07:33 INFO - Using the following test package requirements: 22:07:33 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 22:07:33 INFO - u'common': [u'target.common.tests.zip'], 22:07:33 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 22:07:33 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 22:07:33 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 22:07:33 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 22:07:33 INFO - u'mozbase': [u'target.common.tests.zip'], 22:07:33 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 22:07:33 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 22:07:33 INFO - u'web-platform': [u'target.common.tests.zip', 22:07:33 INFO - u'target.web-platform.tests.zip'], 22:07:33 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 22:07:33 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 22:07:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Vnyo5g2vT3O3SBVrvvZGXA/artifacts/public/build/target.common.tests.zip 22:07:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Vnyo5g2vT3O3SBVrvvZGXA/artifacts/public/build/target.common.tests.zip'}, attempt #1 22:07:33 INFO - Fetch https://queue.taskcluster.net/v1/task/Vnyo5g2vT3O3SBVrvvZGXA/artifacts/public/build/target.common.tests.zip into memory 22:07:34 INFO - Expected file size: 58246018 22:07:34 INFO - Obtained file size: 58246018 22:07:44 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 22:07:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Vnyo5g2vT3O3SBVrvvZGXA/artifacts/public/build/target.common.tests.zip 22:07:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Vnyo5g2vT3O3SBVrvvZGXA/artifacts/public/build/target.common.tests.zip'}, attempt #1 22:07:44 INFO - Fetch https://queue.taskcluster.net/v1/task/Vnyo5g2vT3O3SBVrvvZGXA/artifacts/public/build/target.common.tests.zip into memory 22:07:45 INFO - Expected file size: 58246018 22:07:45 INFO - Obtained file size: 58246018 22:07:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Vnyo5g2vT3O3SBVrvvZGXA/artifacts/public/build/target.talos.tests.zip 22:07:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Vnyo5g2vT3O3SBVrvvZGXA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 22:07:56 INFO - Fetch https://queue.taskcluster.net/v1/task/Vnyo5g2vT3O3SBVrvvZGXA/artifacts/public/build/target.talos.tests.zip into memory 22:07:57 INFO - Expected file size: 14404152 22:07:57 INFO - Obtained file size: 14404152 22:07:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:07:57 INFO - trying https://queue.taskcluster.net/v1/task/Vnyo5g2vT3O3SBVrvvZGXA/artifacts/public/build/target.tar.bz2 22:07:57 INFO - Downloading https://queue.taskcluster.net/v1/task/Vnyo5g2vT3O3SBVrvvZGXA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 22:07:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Vnyo5g2vT3O3SBVrvvZGXA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 22:07:58 INFO - Downloaded 59120407 bytes. 22:07:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Vnyo5g2vT3O3SBVrvvZGXA/artifacts/public/build/target.tar.bz2 22:07:58 INFO - mkdir: /builds/slave/test/properties 22:07:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:07:58 INFO - Writing to file /builds/slave/test/properties/build_url 22:07:58 INFO - Contents: 22:07:58 INFO - build_url:https://queue.taskcluster.net/v1/task/Vnyo5g2vT3O3SBVrvvZGXA/artifacts/public/build/target.tar.bz2 22:07:58 INFO - Running post-action listener: _resource_record_post_action 22:07:58 INFO - Running post-action listener: set_extra_try_arguments 22:07:58 INFO - [mozharness: 2017-04-06 05:07:58.483806Z] Finished download-and-extract step (success) 22:07:58 INFO - [mozharness: 2017-04-06 05:07:58.483902Z] Running populate-webroot step. 22:07:58 INFO - Running pre-action listener: _resource_record_pre_action 22:07:58 INFO - Running main action method: populate_webroot 22:07:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:07:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:07:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:07:58 INFO - '--tppagecycles', 22:07:58 INFO - '7'], 22:07:58 INFO - 'tests': ['tsvgm']}}, 22:07:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:07:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:07:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:07:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:07:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:07:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:07:58 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 22:07:58 INFO - 'talos_options': ['--disable-e10s'], 22:07:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:07:58 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 22:07:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:07:58 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 22:07:58 INFO - 'talos_options': ['--disable-e10s'], 22:07:58 INFO - 'tests': ['damp', 'tps']}, 22:07:58 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 22:07:58 INFO - 'tests': ['damp', 'tps']}, 22:07:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:07:58 INFO - 'tests': ['dromaeo_dom']}, 22:07:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:07:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:07:58 INFO - 'tests': ['basic_compositor_video']}, 22:07:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:07:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:07:58 INFO - 'tests': ['a11yr', 22:07:58 INFO - 'ts_paint', 22:07:58 INFO - 'tpaint', 22:07:58 INFO - 'sessionrestore', 22:07:58 INFO - 'sessionrestore_no_auto_restore', 22:07:58 INFO - 'tabpaint']}, 22:07:58 INFO - 'other-e10s': {'tests': ['a11yr', 22:07:58 INFO - 'ts_paint', 22:07:58 INFO - 'tpaint', 22:07:58 INFO - 'sessionrestore', 22:07:58 INFO - 'sessionrestore_no_auto_restore', 22:07:58 INFO - 'tabpaint']}, 22:07:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:07:58 INFO - 'ts_paint', 22:07:58 INFO - 'tpaint', 22:07:58 INFO - 'sessionrestore', 22:07:58 INFO - 'sessionrestore_no_auto_restore', 22:07:58 INFO - 'tabpaint']}, 22:07:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:07:58 INFO - 'ts_paint', 22:07:58 INFO - 'tpaint', 22:07:58 INFO - 'sessionrestore', 22:07:58 INFO - 'sessionrestore_no_auto_restore', 22:07:58 INFO - 'tabpaint']}, 22:07:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:07:58 INFO - 'tests': ['a11yr', 22:07:58 INFO - 'ts_paint', 22:07:58 INFO - 'tpaint', 22:07:58 INFO - 'sessionrestore', 22:07:58 INFO - 'sessionrestore_no_auto_restore', 22:07:58 INFO - 'tabpaint']}, 22:07:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:07:58 INFO - 'tests': ['a11yr', 22:07:58 INFO - 'ts_paint', 22:07:58 INFO - 'tpaint', 22:07:58 INFO - 'sessionrestore', 22:07:58 INFO - 'sessionrestore_no_auto_restore', 22:07:58 INFO - 'tabpaint']}, 22:07:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:07:58 INFO - 'tests': ['tsvgx', 22:07:58 INFO - 'tsvgr_opacity', 22:07:58 INFO - 'tart', 22:07:58 INFO - 'tscrollx', 22:07:58 INFO - 'cart', 22:07:58 INFO - 'tsvg_static']}, 22:07:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:07:58 INFO - 'tsvgr_opacity', 22:07:58 INFO - 'tart', 22:07:58 INFO - 'tscrollx', 22:07:58 INFO - 'cart', 22:07:58 INFO - 'tsvg_static']}, 22:07:58 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 22:07:58 INFO - 'talos_options': ['--disable-e10s'], 22:07:58 INFO - 'tests': ['tp5o']}, 22:07:58 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 22:07:58 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 22:07:58 INFO - 'talos_options': ['--disable-e10s', 22:07:58 INFO - '--xperf_path', 22:07:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:07:58 INFO - 'tests': ['tp5n']}, 22:07:58 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 22:07:58 INFO - 'talos_options': ['--xperf_path', 22:07:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:07:58 INFO - 'tests': ['tp5n']}}, 22:07:58 INFO - 'talos.zip': {'path': '', 22:07:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:07:58 INFO - Running post-action listener: _resource_record_post_action 22:07:58 INFO - [mozharness: 2017-04-06 05:07:58.497051Z] Finished populate-webroot step (success) 22:07:58 INFO - [mozharness: 2017-04-06 05:07:58.497140Z] Running create-virtualenv step. 22:07:58 INFO - Running pre-action listener: _resource_record_pre_action 22:07:58 INFO - Running main action method: create_virtualenv 22:07:58 INFO - Creating virtualenv /builds/slave/test/build/venv 22:07:58 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 22:07:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:07:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:07:58 INFO - Using real prefix '/usr' 22:07:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:07:59 INFO - Installing distribute.............................................................................................................................................................................................done. 22:08:01 INFO - Installing pip.................done. 22:08:01 INFO - Return code: 0 22:08:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 22:08:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 22:08:01 INFO - Reading from file tmpfile_stdout 22:08:01 INFO - Output received: 22:08:01 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) 22:08:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:08:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:08:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:08:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:08:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:01 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 0xffe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x129c310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1299400>, '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 0x129a3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x129a840>, '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': '14ef55db36f7623abb31b9cf000001d5-1491455248.489998-1886381097', '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 22:08:01 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 22:08:01 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 22:08:01 INFO - Using env: {'DISPLAY': ':0', 22:08:01 INFO - 'HOME': '/home/cltbld', 22:08:01 INFO - 'LANG': 'en_US.UTF-8', 22:08:01 INFO - 'LANGUAGE': 'en_US:en', 22:08:01 INFO - 'LOGNAME': 'cltbld', 22:08:01 INFO - 'MAIL': '/var/mail/cltbld', 22:08:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:01 INFO - 'MOZ_NO_REMOTE': '1', 22:08:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:01 INFO - 'NO_EM_RESTART': '1', 22:08:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:01 INFO - 'PWD': '/builds/slave/test', 22:08:01 INFO - 'SHELL': '/bin/bash', 22:08:01 INFO - 'SHLVL': '1', 22:08:01 INFO - 'TERM': 'linux', 22:08:01 INFO - 'TMOUT': '86400', 22:08:01 INFO - 'USER': 'cltbld', 22:08:01 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1491455248.489998-1886381097', 22:08:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:01 INFO - '_': '/tools/buildbot/bin/python'} 22:08:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:08:01 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 22:08:01 INFO - Cleaning up... 22:08:01 INFO - Return code: 0 22:08:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:08:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:08:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:08:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:08:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:01 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 0xffe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x129c310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1299400>, '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 0x129a3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x129a840>, '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': '14ef55db36f7623abb31b9cf000001d5-1491455248.489998-1886381097', '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 22:08:01 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 22:08:01 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 22:08:01 INFO - Using env: {'DISPLAY': ':0', 22:08:01 INFO - 'HOME': '/home/cltbld', 22:08:01 INFO - 'LANG': 'en_US.UTF-8', 22:08:01 INFO - 'LANGUAGE': 'en_US:en', 22:08:01 INFO - 'LOGNAME': 'cltbld', 22:08:01 INFO - 'MAIL': '/var/mail/cltbld', 22:08:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:01 INFO - 'MOZ_NO_REMOTE': '1', 22:08:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:01 INFO - 'NO_EM_RESTART': '1', 22:08:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:01 INFO - 'PWD': '/builds/slave/test', 22:08:01 INFO - 'SHELL': '/bin/bash', 22:08:01 INFO - 'SHLVL': '1', 22:08:01 INFO - 'TERM': 'linux', 22:08:01 INFO - 'TMOUT': '86400', 22:08:01 INFO - 'USER': 'cltbld', 22:08:01 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1491455248.489998-1886381097', 22:08:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:01 INFO - '_': '/tools/buildbot/bin/python'} 22:08:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:08:01 INFO - Downloading/unpacking psutil>=3.1.1 22:08:01 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 22:08:01 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 22:08:01 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 22:08:01 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 22:08:01 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 22:08:01 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 22:08:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:08:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:08:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:08:03 INFO - Installing collected packages: psutil 22:08:03 INFO - Running setup.py install for psutil 22:08:03 INFO - building 'psutil._psutil_linux' extension 22:08:03 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 22:08:04 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 22:08:04 INFO - building 'psutil._psutil_posix' extension 22:08:04 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 22:08:04 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 22:08:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:08:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:08:04 INFO - Successfully installed psutil 22:08:04 INFO - Cleaning up... 22:08:04 INFO - Return code: 0 22:08:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:08:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:08:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:08:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:08:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:04 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 0xffe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x129c310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1299400>, '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 0x129a3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x129a840>, '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': '14ef55db36f7623abb31b9cf000001d5-1491455248.489998-1886381097', '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 22:08:04 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 22:08:04 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 22:08:04 INFO - Using env: {'DISPLAY': ':0', 22:08:04 INFO - 'HOME': '/home/cltbld', 22:08:04 INFO - 'LANG': 'en_US.UTF-8', 22:08:04 INFO - 'LANGUAGE': 'en_US:en', 22:08:04 INFO - 'LOGNAME': 'cltbld', 22:08:04 INFO - 'MAIL': '/var/mail/cltbld', 22:08:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:04 INFO - 'MOZ_NO_REMOTE': '1', 22:08:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:04 INFO - 'NO_EM_RESTART': '1', 22:08:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:04 INFO - 'PWD': '/builds/slave/test', 22:08:04 INFO - 'SHELL': '/bin/bash', 22:08:04 INFO - 'SHLVL': '1', 22:08:04 INFO - 'TERM': 'linux', 22:08:04 INFO - 'TMOUT': '86400', 22:08:04 INFO - 'USER': 'cltbld', 22:08:04 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1491455248.489998-1886381097', 22:08:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:04 INFO - '_': '/tools/buildbot/bin/python'} 22:08:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:08:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:08:04 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 22:08:04 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 22:08:04 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 22:08:04 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 22:08:04 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 22:08:04 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 22:08:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:08:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:08:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:08:06 INFO - Installing collected packages: mozsystemmonitor 22:08:06 INFO - Running setup.py install for mozsystemmonitor 22:08:06 INFO - Successfully installed mozsystemmonitor 22:08:06 INFO - Cleaning up... 22:08:06 INFO - Return code: 0 22:08:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:08:06 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')]} 22:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:08:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:06 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')]} 22:08:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:08:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:06 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 0xffe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x129c310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1299400>, '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 0x129a3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x129a840>, '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': '14ef55db36f7623abb31b9cf000001d5-1491455248.489998-1886381097', '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 22:08:06 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 22:08:06 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 22:08:06 INFO - Using env: {'DISPLAY': ':0', 22:08:06 INFO - 'HOME': '/home/cltbld', 22:08:06 INFO - 'LANG': 'en_US.UTF-8', 22:08:06 INFO - 'LANGUAGE': 'en_US:en', 22:08:06 INFO - 'LOGNAME': 'cltbld', 22:08:06 INFO - 'MAIL': '/var/mail/cltbld', 22:08:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:06 INFO - 'MOZ_NO_REMOTE': '1', 22:08:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:06 INFO - 'NO_EM_RESTART': '1', 22:08:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:06 INFO - 'PWD': '/builds/slave/test', 22:08:06 INFO - 'SHELL': '/bin/bash', 22:08:06 INFO - 'SHLVL': '1', 22:08:06 INFO - 'TERM': 'linux', 22:08:06 INFO - 'TMOUT': '86400', 22:08:06 INFO - 'USER': 'cltbld', 22:08:06 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1491455248.489998-1886381097', 22:08:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:06 INFO - '_': '/tools/buildbot/bin/python'} 22:08:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:08:06 INFO - Downloading/unpacking jsonschema==2.5.1 22:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:08:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:08:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:08:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:08:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:08:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:08:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:08:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:08:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:08:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:08:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:08:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:08:09 INFO - Downloading functools32-3.2.3-2.tar.gz 22:08:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:08:09 INFO - warning: no files found matching '*.txt' 22:08:09 INFO - no previously-included directories found matching 'build' 22:08:09 INFO - no previously-included directories found matching 'dist' 22:08:09 INFO - no previously-included directories found matching '.git*' 22:08:09 INFO - Installing collected packages: jsonschema, functools32 22:08:09 INFO - Running setup.py install for functools32 22:08:09 INFO - warning: no files found matching '*.txt' 22:08:09 INFO - no previously-included directories found matching 'build' 22:08:09 INFO - no previously-included directories found matching 'dist' 22:08:09 INFO - no previously-included directories found matching '.git*' 22:08:09 INFO - Successfully installed jsonschema functools32 22:08:09 INFO - Cleaning up... 22:08:09 INFO - Return code: 0 22:08:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:08:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:08:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:08:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:08:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xffe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x129c310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1299400>, '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 0x129a3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x129a840>, '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': '14ef55db36f7623abb31b9cf000001d5-1491455248.489998-1886381097', '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 22:08:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 22:08:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 22:08:09 INFO - Using env: {'DISPLAY': ':0', 22:08:09 INFO - 'HOME': '/home/cltbld', 22:08:09 INFO - 'LANG': 'en_US.UTF-8', 22:08:09 INFO - 'LANGUAGE': 'en_US:en', 22:08:09 INFO - 'LOGNAME': 'cltbld', 22:08:09 INFO - 'MAIL': '/var/mail/cltbld', 22:08:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:09 INFO - 'MOZ_NO_REMOTE': '1', 22:08:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:09 INFO - 'NO_EM_RESTART': '1', 22:08:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:09 INFO - 'PWD': '/builds/slave/test', 22:08:09 INFO - 'SHELL': '/bin/bash', 22:08:09 INFO - 'SHLVL': '1', 22:08:09 INFO - 'TERM': 'linux', 22:08:09 INFO - 'TMOUT': '86400', 22:08:09 INFO - 'USER': 'cltbld', 22:08:09 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1491455248.489998-1886381097', 22:08:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:09 INFO - '_': '/tools/buildbot/bin/python'} 22:08:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:08:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:08:09 INFO - Cleaning up... 22:08:09 INFO - Return code: 0 22:08:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:08:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:08:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:08:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:08:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xffe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x129c310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1299400>, '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 0x129a3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x129a840>, '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': '14ef55db36f7623abb31b9cf000001d5-1491455248.489998-1886381097', '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 22:08:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:08:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:08:09 INFO - Using env: {'DISPLAY': ':0', 22:08:09 INFO - 'HOME': '/home/cltbld', 22:08:09 INFO - 'LANG': 'en_US.UTF-8', 22:08:09 INFO - 'LANGUAGE': 'en_US:en', 22:08:09 INFO - 'LOGNAME': 'cltbld', 22:08:09 INFO - 'MAIL': '/var/mail/cltbld', 22:08:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:09 INFO - 'MOZ_NO_REMOTE': '1', 22:08:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:09 INFO - 'NO_EM_RESTART': '1', 22:08:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:09 INFO - 'PWD': '/builds/slave/test', 22:08:09 INFO - 'SHELL': '/bin/bash', 22:08:09 INFO - 'SHLVL': '1', 22:08:09 INFO - 'TERM': 'linux', 22:08:09 INFO - 'TMOUT': '86400', 22:08:09 INFO - 'USER': 'cltbld', 22:08:09 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1491455248.489998-1886381097', 22:08:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:09 INFO - '_': '/tools/buildbot/bin/python'} 22:08:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:08:09 INFO - Downloading/unpacking blobuploader==1.2.4 22:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:08:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:08:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:08:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:08:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:08:11 INFO - Downloading blobuploader-1.2.4.tar.gz 22:08:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:08:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:08:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:08:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:08:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:08:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:08:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:08:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:08:12 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 22:08:12 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 22:08:12 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 22:08:12 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 22:08:12 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 22:08:12 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 22:08:12 INFO - Downloading docopt-0.6.1.tar.gz 22:08:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:08:12 INFO - Installing collected packages: blobuploader, requests, docopt 22:08:12 INFO - Running setup.py install for blobuploader 22:08:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:08:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:08:12 INFO - Running setup.py install for requests 22:08:13 INFO - Running setup.py install for docopt 22:08:13 INFO - Successfully installed blobuploader requests docopt 22:08:13 INFO - Cleaning up... 22:08:13 INFO - Return code: 0 22:08:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:08:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:08:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:08:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:08:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:08:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:13 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 0xffe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x129c310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1299400>, '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 0x129a3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x129a840>, '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': '14ef55db36f7623abb31b9cf000001d5-1491455248.489998-1886381097', '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 22:08:13 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 22:08:13 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 22:08:13 INFO - Using env: {'DISPLAY': ':0', 22:08:13 INFO - 'HOME': '/home/cltbld', 22:08:13 INFO - 'LANG': 'en_US.UTF-8', 22:08:13 INFO - 'LANGUAGE': 'en_US:en', 22:08:13 INFO - 'LOGNAME': 'cltbld', 22:08:13 INFO - 'MAIL': '/var/mail/cltbld', 22:08:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:13 INFO - 'MOZ_NO_REMOTE': '1', 22:08:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:13 INFO - 'NO_EM_RESTART': '1', 22:08:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:13 INFO - 'PWD': '/builds/slave/test', 22:08:13 INFO - 'SHELL': '/bin/bash', 22:08:13 INFO - 'SHLVL': '1', 22:08:13 INFO - 'TERM': 'linux', 22:08:13 INFO - 'TMOUT': '86400', 22:08:13 INFO - 'USER': 'cltbld', 22:08:13 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1491455248.489998-1886381097', 22:08:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:13 INFO - '_': '/tools/buildbot/bin/python'} 22:08:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:08:13 INFO - Running setup.py (path:/tmp/pip-KVi7nU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:08:13 INFO - Running setup.py (path:/tmp/pip-t73Dni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:08:13 INFO - Running setup.py (path:/tmp/pip-h7KkCe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:08:13 INFO - Running setup.py (path:/tmp/pip-UfBP1U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:08:13 INFO - Running setup.py (path:/tmp/pip-J9QiHX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:08:13 INFO - Running setup.py (path:/tmp/pip-viJV2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:08:13 INFO - Running setup.py (path:/tmp/pip-wUVXLJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:08:14 INFO - Running setup.py (path:/tmp/pip-JLJUcx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:08:14 INFO - Running setup.py (path:/tmp/pip-8PGN5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:08:14 INFO - Running setup.py (path:/tmp/pip-uufLzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:08:14 INFO - Running setup.py (path:/tmp/pip-xmBvvf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:08:14 INFO - Running setup.py (path:/tmp/pip-6jEEGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:08:14 INFO - Running setup.py (path:/tmp/pip-zLk_Kk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:08:14 INFO - Running setup.py (path:/tmp/pip-zW5zl6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:08:14 INFO - Running setup.py (path:/tmp/pip-C2YS8Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:08:14 INFO - Running setup.py (path:/tmp/pip-ob71Tb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:08:14 INFO - Running setup.py (path:/tmp/pip-eHgOA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:08:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:08:14 INFO - Running setup.py install for manifestparser 22:08:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:08:14 INFO - Running setup.py install for mozcrash 22:08:14 INFO - Running setup.py install for mozdebug 22:08:15 INFO - Running setup.py install for mozdevice 22:08:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:08:15 INFO - Running setup.py install for mozfile 22:08:15 INFO - Running setup.py install for mozhttpd 22:08:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:08:15 INFO - Running setup.py install for mozinfo 22:08:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:08:15 INFO - Running setup.py install for mozInstall 22:08:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:08:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:08:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:08:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:08:15 INFO - Running setup.py install for mozleak 22:08:15 INFO - Running setup.py install for mozlog 22:08:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:08:15 INFO - Running setup.py install for moznetwork 22:08:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:08:15 INFO - Running setup.py install for mozprocess 22:08:15 INFO - Running setup.py install for mozprofile 22:08:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:08:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:08:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:08:16 INFO - Running setup.py install for mozrunner 22:08:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:08:16 INFO - Running setup.py install for mozscreenshot 22:08:16 INFO - Running setup.py install for moztest 22:08:16 INFO - Running setup.py install for mozversion 22:08:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:08:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:08:16 INFO - Cleaning up... 22:08:16 INFO - Return code: 0 22:08:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:08:16 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')]} 22:08:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:08:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:16 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')]} 22:08:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:08:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:16 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 0xffe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x129c310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1299400>, '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 0x129a3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x129a840>, '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': '14ef55db36f7623abb31b9cf000001d5-1491455248.489998-1886381097', '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 22:08:16 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 22:08:16 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 22:08:16 INFO - Using env: {'DISPLAY': ':0', 22:08:16 INFO - 'HOME': '/home/cltbld', 22:08:16 INFO - 'LANG': 'en_US.UTF-8', 22:08:16 INFO - 'LANGUAGE': 'en_US:en', 22:08:16 INFO - 'LOGNAME': 'cltbld', 22:08:16 INFO - 'MAIL': '/var/mail/cltbld', 22:08:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:16 INFO - 'MOZ_NO_REMOTE': '1', 22:08:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:16 INFO - 'NO_EM_RESTART': '1', 22:08:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:16 INFO - 'PWD': '/builds/slave/test', 22:08:16 INFO - 'SHELL': '/bin/bash', 22:08:16 INFO - 'SHLVL': '1', 22:08:16 INFO - 'TERM': 'linux', 22:08:16 INFO - 'TMOUT': '86400', 22:08:16 INFO - 'USER': 'cltbld', 22:08:16 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1491455248.489998-1886381097', 22:08:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:16 INFO - '_': '/tools/buildbot/bin/python'} 22:08:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:08:16 INFO - Running setup.py (path:/tmp/pip-ZpYnmr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:08:16 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)) 22:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:08:16 INFO - Running setup.py (path:/tmp/pip-CO5o0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:08:16 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)) 22:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:08:16 INFO - Running setup.py (path:/tmp/pip-usjzaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:08:16 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)) 22:08:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:08:16 INFO - Running setup.py (path:/tmp/pip-ggPko5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:08:17 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)) 22:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:08:17 INFO - Running setup.py (path:/tmp/pip-DrJ7sq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:08:17 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)) 22:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:08:17 INFO - Running setup.py (path:/tmp/pip-6FZ12L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:08:17 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)) 22:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:08:17 INFO - Running setup.py (path:/tmp/pip-ZUnMWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:08:17 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)) 22:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:08:17 INFO - Running setup.py (path:/tmp/pip-nGY8EB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:08:17 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)) 22:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:08:17 INFO - Running setup.py (path:/tmp/pip-SJakW2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:08:17 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)) 22:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:08:17 INFO - Running setup.py (path:/tmp/pip-lk5uCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:08:17 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)) 22:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:08:17 INFO - Running setup.py (path:/tmp/pip-In1NYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:08:17 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)) 22:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:08:17 INFO - Running setup.py (path:/tmp/pip-_tSxMz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:08:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 22:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:08:17 INFO - Running setup.py (path:/tmp/pip-yxb7y2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:08:17 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)) 22:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:08:17 INFO - Running setup.py (path:/tmp/pip-adtWUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:08:17 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)) 22:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:08:17 INFO - Running setup.py (path:/tmp/pip-L2z45a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:08:17 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)) 22:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:08:17 INFO - Running setup.py (path:/tmp/pip-AAEf8L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:08:17 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)) 22:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:08:17 INFO - Running setup.py (path:/tmp/pip-kmAw5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:08:17 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)) 22:08:17 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)) 22:08:17 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)) 22:08:17 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)) 22:08:17 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)) 22:08:17 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)) 22:08:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:08:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:08:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:08:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:08:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:08:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:08:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:08:19 INFO - Downloading blessings-1.6.tar.gz 22:08:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:08:20 INFO - Installing collected packages: blessings 22:08:20 INFO - Running setup.py install for blessings 22:08:20 INFO - Successfully installed blessings 22:08:20 INFO - Cleaning up... 22:08:20 INFO - Return code: 0 22:08:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:08:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:08:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:08:20 INFO - Reading from file tmpfile_stdout 22:08:20 INFO - Current package versions: 22:08:20 INFO - argparse == 1.2.1 22:08:20 INFO - blessings == 1.6 22:08:20 INFO - blobuploader == 1.2.4 22:08:20 INFO - docopt == 0.6.1 22:08:20 INFO - functools32 == 3.2.3-2 22:08:20 INFO - jsonschema == 2.5.1 22:08:20 INFO - manifestparser == 1.1 22:08:20 INFO - mozInstall == 1.12 22:08:20 INFO - mozcrash == 1.0 22:08:20 INFO - mozdebug == 0.1 22:08:20 INFO - mozdevice == 0.49 22:08:20 INFO - mozfile == 1.2 22:08:20 INFO - mozhttpd == 0.7 22:08:20 INFO - mozinfo == 0.9 22:08:20 INFO - mozleak == 0.1 22:08:20 INFO - mozlog == 3.4 22:08:20 INFO - moznetwork == 0.27 22:08:20 INFO - mozprocess == 0.25 22:08:20 INFO - mozprofile == 0.28 22:08:20 INFO - mozrunner == 6.13 22:08:20 INFO - mozscreenshot == 0.1 22:08:20 INFO - mozsystemmonitor == 0.3 22:08:20 INFO - moztest == 0.8 22:08:20 INFO - mozversion == 1.4 22:08:20 INFO - psutil == 3.1.1 22:08:20 INFO - requests == 1.2.3 22:08:20 INFO - wsgiref == 0.1.2 22:08:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:08:20 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')]} 22:08:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:08:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:20 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')]} 22:08:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:08:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:20 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 0xffe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x129c310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1299400>, '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 0x129a3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x129a840>, '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': '14ef55db36f7623abb31b9cf000001d5-1491455248.489998-1886381097', '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 22:08:20 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 22:08:20 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 22:08:20 INFO - Using env: {'DISPLAY': ':0', 22:08:20 INFO - 'HOME': '/home/cltbld', 22:08:20 INFO - 'LANG': 'en_US.UTF-8', 22:08:20 INFO - 'LANGUAGE': 'en_US:en', 22:08:20 INFO - 'LOGNAME': 'cltbld', 22:08:20 INFO - 'MAIL': '/var/mail/cltbld', 22:08:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:20 INFO - 'MOZ_NO_REMOTE': '1', 22:08:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:20 INFO - 'NO_EM_RESTART': '1', 22:08:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:20 INFO - 'PWD': '/builds/slave/test', 22:08:20 INFO - 'SHELL': '/bin/bash', 22:08:20 INFO - 'SHLVL': '1', 22:08:20 INFO - 'TERM': 'linux', 22:08:20 INFO - 'TMOUT': '86400', 22:08:20 INFO - 'USER': 'cltbld', 22:08:20 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1491455248.489998-1886381097', 22:08:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:20 INFO - '_': '/tools/buildbot/bin/python'} 22:08:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:08:20 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)) 22:08:20 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)) 22:08:20 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)) 22:08:20 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)) 22:08:20 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)) 22:08:20 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)) 22:08:20 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)) 22:08:20 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)) 22:08:20 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)) 22:08:20 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)) 22:08:20 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)) 22:08:20 INFO - Cleaning up... 22:08:20 INFO - Return code: 0 22:08:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:08:20 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')]} 22:08:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:08:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:20 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')]} 22:08:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:08:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:08:20 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 0xffe1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x129c310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1299400>, '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 0x129a3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x129a840>, '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': '14ef55db36f7623abb31b9cf000001d5-1491455248.489998-1886381097', '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 22:08:20 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 22:08:20 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 22:08:20 INFO - Using env: {'DISPLAY': ':0', 22:08:20 INFO - 'HOME': '/home/cltbld', 22:08:20 INFO - 'LANG': 'en_US.UTF-8', 22:08:20 INFO - 'LANGUAGE': 'en_US:en', 22:08:20 INFO - 'LOGNAME': 'cltbld', 22:08:20 INFO - 'MAIL': '/var/mail/cltbld', 22:08:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:20 INFO - 'MOZ_NO_REMOTE': '1', 22:08:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:20 INFO - 'NO_EM_RESTART': '1', 22:08:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:20 INFO - 'PWD': '/builds/slave/test', 22:08:20 INFO - 'SHELL': '/bin/bash', 22:08:20 INFO - 'SHLVL': '1', 22:08:20 INFO - 'TERM': 'linux', 22:08:20 INFO - 'TMOUT': '86400', 22:08:20 INFO - 'USER': 'cltbld', 22:08:20 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1491455248.489998-1886381097', 22:08:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:20 INFO - '_': '/tools/buildbot/bin/python'} 22:08:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:08:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:08:20 INFO - Cleaning up... 22:08:20 INFO - Return code: 0 22:08:20 INFO - Running post-action listener: _resource_record_post_action 22:08:20 INFO - Running post-action listener: _start_resource_monitoring 22:08:20 INFO - Starting resource monitoring. 22:08:20 INFO - [mozharness: 2017-04-06 05:08:20.936530Z] Finished create-virtualenv step (success) 22:08:20 INFO - [mozharness: 2017-04-06 05:08:20.937102Z] Running install step. 22:08:20 INFO - Running pre-action listener: _resource_record_pre_action 22:08:20 INFO - Running main action method: install 22:08:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:08:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:08:21 INFO - Reading from file tmpfile_stdout 22:08:21 INFO - Detecting whether we're running mozinstall >=1.0... 22:08:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:08:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:08:21 INFO - Reading from file tmpfile_stdout 22:08:21 INFO - Output received: 22:08:21 INFO - Usage: mozinstall [options] installer 22:08:21 INFO - Options: 22:08:21 INFO - -h, --help show this help message and exit 22:08:21 INFO - -d DEST, --destination=DEST 22:08:21 INFO - Directory to install application into. [default: 22:08:21 INFO - "/builds/slave/test"] 22:08:21 INFO - --app=APP Application being installed. [default: firefox] 22:08:21 INFO - mkdir: /builds/slave/test/build/application 22:08:21 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'] 22:08:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 22:08:36 INFO - Reading from file tmpfile_stdout 22:08:36 INFO - Output received: 22:08:36 INFO - /builds/slave/test/build/application/firefox/firefox 22:08:36 INFO - Running post-action listener: _resource_record_post_action 22:08:36 INFO - [mozharness: 2017-04-06 05:08:36.302691Z] Finished install step (success) 22:08:36 INFO - [mozharness: 2017-04-06 05:08:36.302968Z] Running run-tests step. 22:08:36 INFO - Running pre-action listener: _resource_record_pre_action 22:08:36 INFO - Running main action method: run_tests 22:08:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:08:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:08:36 INFO - Python 2.7.3 22:08:36 INFO - Return code: 0 22:08:36 INFO - grabbing minidump binary from tooltool 22:08:36 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')]} 22:08:36 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 0x1299400>, '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 0x129a3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x129a840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:08:36 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 22:08:36 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 22:08:36 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 22:08:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:08:36 INFO - Return code: 0 22:08:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:08:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:08:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:08:36 INFO - ENV: RUST_BACKTRACE is now 1 22:08:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:08:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:08:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Vnyo5g2vT3O3SBVrvvZGXA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 22:08:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Vnyo5g2vT3O3SBVrvvZGXA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-036 --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 22:08:36 INFO - Using env: {'DISPLAY': ':0', 22:08:36 INFO - 'HOME': '/home/cltbld', 22:08:36 INFO - 'LANG': 'en_US.UTF-8', 22:08:36 INFO - 'LANGUAGE': 'en_US:en', 22:08:36 INFO - 'LOGNAME': 'cltbld', 22:08:36 INFO - 'MAIL': '/var/mail/cltbld', 22:08:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:08:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:08:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:08:36 INFO - 'MOZ_NO_REMOTE': '1', 22:08:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:08:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:08:36 INFO - 'NO_EM_RESTART': '1', 22:08:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:08:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:08:36 INFO - 'PWD': '/builds/slave/test', 22:08:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:08:36 INFO - 'RUST_BACKTRACE': '1', 22:08:36 INFO - 'SHELL': '/bin/bash', 22:08:36 INFO - 'SHLVL': '1', 22:08:36 INFO - 'TERM': 'linux', 22:08:36 INFO - 'TMOUT': '86400', 22:08:36 INFO - 'USER': 'cltbld', 22:08:36 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1491455248.489998-1886381097', 22:08:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:08:36 INFO - '_': '/tools/buildbot/bin/python'} 22:08:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Vnyo5g2vT3O3SBVrvvZGXA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 22:08:36 INFO - mozversion application_buildid: 20170406043223 22:08:36 INFO - mozversion application_changeset: ec8d1d3db50c85037e8077c32c8403570a5df493 22:08:36 INFO - mozversion application_display_name: Nightly 22:08:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:08:36 INFO - mozversion application_name: Firefox 22:08:36 INFO - mozversion application_remotingname: firefox 22:08:36 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 22:08:36 INFO - mozversion application_vendor: Mozilla 22:08:36 INFO - mozversion application_version: 55.0a1 22:08:36 INFO - mozversion platform_buildid: 20170406043223 22:08:36 INFO - mozversion platform_changeset: ec8d1d3db50c85037e8077c32c8403570a5df493 22:08:36 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 22:08:36 INFO - mozversion platform_version: 55.0a1 22:08:36 INFO - using testdate: 1491455316 22:08:36 INFO - actual date: 1491455316 22:08:36 INFO - starting webserver on 'localhost:38956' 22:08:36 INFO - SUITE-START | Running 2 tests 22:08:36 INFO - TEST-START | dromaeo_css 22:08:36 INFO - operating with platform_type : linux_ 22:08:36 INFO - Initialising browser for dromaeo_css test... 22:08:36 INFO - TEST-INFO | started process 29908 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFEl8Zi/profile http://localhost:38956/getInfo.html) 22:08:40 INFO - PID 29908 | __metrics Screen width/height:1600/1200 22:08:40 INFO - PID 29908 | colorDepth:24 22:08:40 INFO - PID 29908 | Browser inner width/height: 1024/697 22:08:40 INFO - PID 29908 | __metrics 22:08:42 INFO - PID 29908 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:08:42 INFO - PID 29908 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 304: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:08:43 INFO - TEST-INFO | 29908: exit 0 22:08:43 INFO - Browser initialized. 22:08:43 INFO - Running cycle 1/1 for dromaeo_css test... 22:08:43 INFO - TEST-INFO | started process 30010 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFEl8Zi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:08:55 INFO - PID 30010 | RSS: Main: 169951232 22:08:55 INFO - PID 30010 | 22:12:03 INFO - PID 30010 | Cycle 1(1): loaded http://localhost:38956/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38956/tests/dromaeo/cssquery-ext.html) 22:12:05 INFO - PID 30010 | RSS: Main: 297390080 22:12:05 INFO - PID 30010 | 22:13:45 INFO - PID 30010 | ************************* 22:13:45 INFO - PID 30010 | A coding exception was thrown and uncaught in a Task. 22:13:45 INFO - PID 30010 | 22:13:45 ERROR - PID 30010 | Full message: TypeError: NetworkError when attempting to fetch resource. 22:13:45 INFO - PID 30010 | Full stack: 22:13:45 INFO - PID 30010 | ************************* 22:13:45 INFO - PID 30010 | ************************* 22:13:45 INFO - PID 30010 | A coding exception was thrown and uncaught in a Task. 22:13:45 INFO - PID 30010 | 22:13:45 ERROR - PID 30010 | Full message: TypeError: NetworkError when attempting to fetch resource. 22:13:45 INFO - PID 30010 | Full stack: 22:13:45 INFO - PID 30010 | ************************* 22:13:45 INFO - PID 30010 | ************************* 22:13:45 INFO - PID 30010 | A coding exception was thrown and uncaught in a Task. 22:13:45 INFO - PID 30010 | 22:13:45 ERROR - PID 30010 | Full message: TypeError: NetworkError when attempting to fetch resource. 22:13:45 INFO - PID 30010 | Full stack: 22:13:45 INFO - PID 30010 | ************************* 22:13:45 INFO - PID 30010 | ************************* 22:13:45 INFO - PID 30010 | A coding exception was thrown and uncaught in a Task. 22:13:45 INFO - PID 30010 | 22:13:45 ERROR - PID 30010 | Full message: TypeError: NetworkError when attempting to fetch resource. 22:13:45 INFO - PID 30010 | Full stack: 22:13:45 INFO - PID 30010 | ************************* 22:15:07 INFO - PID 30010 | Cycle 1(1): loaded http://localhost:38956/tests/dromaeo/cssquery-ext.html (next: http://localhost:38956/tests/dromaeo/cssquery-jquery.html) 22:15:08 INFO - PID 30010 | RSS: Main: 258215936 22:15:08 INFO - PID 30010 | 22:18:10 INFO - PID 30010 | Cycle 1(1): loaded http://localhost:38956/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38956/tests/dromaeo/cssquery-mootools.html) 22:18:10 INFO - PID 30010 | RSS: Main: 200974336 22:18:10 INFO - PID 30010 | 22:21:12 INFO - PID 30010 | Cycle 1(1): loaded http://localhost:38956/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38956/tests/dromaeo/cssquery-prototype.html) 22:21:13 INFO - PID 30010 | RSS: Main: 234000384 22:21:13 INFO - PID 30010 | 22:24:16 INFO - PID 30010 | Cycle 1(1): loaded http://localhost:38956/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38956/tests/dromaeo/cssquery-yui.html) 22:24:17 INFO - PID 30010 | RSS: Main: 216436736 22:24:17 INFO - PID 30010 | 22:27:20 INFO - PID 30010 | Cycle 1(1): loaded http://localhost:38956/tests/dromaeo/cssquery-yui.html (next: http://localhost:38956/tests/dromaeo/cssquery-dojo.html) 22:27:20 INFO - PID 30010 | RSS: Main: 286543872 22:27:20 INFO - PID 30010 | 22:27:20 INFO - PID 30010 | __start_tp_report 22:27:20 INFO - PID 30010 | _x_x_mozilla_page_load 22:27:20 INFO - PID 30010 | _x_x_mozilla_page_load_details 22:27:20 INFO - PID 30010 | |i|pagename|runs| 22:27:20 INFO - PID 30010 | |0;dojo.html;2734.3984323448835;2758.241483592011;2799.3561480859403;2802.3974845408234;2817.422428402177;5118.897622047557;5250.396204436491;5273.736313184339;5307.256984022235;5347.919781203285;5242.737863106839;5243.239730239113;5263.921041184385;5265.394479634843;5271.525562699357;4669.906601867969;4699.647526435514;4731.9763401182945;4735.668503204777;4769.713817170964;4706.647001474886;4742.834000809972;4749.525047495257;4750.857474275777;4751.643626727992;4742.33607294979;4749.121412538691;4753.144434001878;4759.024399998009;4782.1153086678905;4764.97617511912;4797.592204662608;4801.063792560452;4801.375821143229;4829.6860704054125;4737.170995075848;4777.689450185761;4780.259059845729;4780.713157210544;4814.253790662453;4768.928466073012;4941.505849415065;5121.129408000612;5204.68771873685;5270.288511050997;5599.216109744639;5690.800821971211;5695.373508914016;5696.857578560528;5701.458361455655;5795.594308398414;5824.563157763142;5842.591018628697;5843.094320380348;5844.590878638497;5357.196420536911;5363.115086010765;5370.838874833761;5373.516383525423;5373.946260537345;5741.397153298927;5912.793052243151;5914.733836977261;5916;5934.109883517507;5473.8357849264585;5604.327480702342;5672.319321681342;5677.829665110054;5691.772329106872;5747.626404283708;5765.769369225184;5766.106253530709;5766.769329226868;5767.826965191051;5682.431756824284;5727;5735.340435849847;5738.68437235956;5742.856428589319;5520.889582208333;5602.607817452821;5605.131204663284;5714.200011998323;5760.855978600484;4725.267583524559;4769.046190761862;4778.832740854123;4785.9760701196965;4801.855944321676;4052.615001574846;4057.634812866856;4060.1879624075304;4064.7154699171365;4090.3250963590676;4842.225243960949;4847.684900481458;4853.247746599282;4855.077535268288;4888.608911287089;5617.9438205618235;5628.71856407178;5684.54523638108;5693.715314234271;5697.3448053474385;4810.013947140827;4816.723568254415;4819.903601927942;4822.734749588736;4824.131656301899;5029.64792464524;5056.797728090835;5058.519440653132;5070.366204224472;5079.08576456234;5313.1764576490705;5318.228856815663;5326.067938110893;5363.463653634605;5425.213344065168;5800.187973683604;5805.390434004369;5806.854828629318;5818.883622327615;5861.6189947653265;5398.325209348832;5408.891822163613;5412.079946409041;5412.566994640498;5412.78348866041;5491.588130890119;5565.359983601776;5570;5683.431656834284;5688.744006519633;5745.712714364181;5780.537556995514;5813.3605303417435;5827.446392592697;5836.095405212199;5553.305836770403;5561.054620714569;5561.499465048003;5564.610477266552;5566.749496272759;5428.430014848384;5587.664740115606;5601.383847776659;5604.6917419542315;5605;5426.403095659395;5443.700596467233;5473.151661492475;5518.255035570147;5533.861653458695;5634.971825141012;5649.7740090397565;5651.095824668033;5652.7738890443925;5654.547636189177;5469.917951230815;5478.45215478449;5485.286912701324;5485.451454854483;5488.643238189505 22:27:20 INFO - PID 30010 | |1;ext.html;672.549391907422;717.9533330333528;739.5230076600593;1074.129954736663;1093.4478088565274;26117.347066323353;26724;26726.866365668193;26757;26758.12007258949;33050.66949330506;33526.664733352656;33559;33579.664203357956;33625.66374336256;7205.639718014091;7341.8898716519025;7346.632668366587;7351.669174887116;7358.153812311599;5497.835064948058;5644.604877658566;7213;7317.926820731805;7323.194448610649;7043.471739619549;7264.309890560388;7271.963640181792;7291.781246562585;7292;7274.563526188419;7336.339729424378;7341.632918354061;7344;7346.118465784113;5379.273798037254;5566.944330556683;5573.8606534836545;7160.498765086446;7241.637918104074;24468.632970505278;30405.543916841267;30730.539041914388;30931.536026959613;30952.8452357739;2961.748251398612;2992.2668946108342;2997.640283166034;2998.8050776699447;2999.1902186409548;24109.397265068514;24191.15330963408;24305;24329.148479803123;24404.511909761884;2734.220747087071;2760.489309477753;2776.0977682253347;2799.1042866282796;2880.4095160492047;133280;133559;133718.33140834235;133752;133938;40838.59161408407;40873.386899196536;40916.590834091876;40930.59069409328;40950.795246023576;42459.150816983485;42847.78576107162;42893.78553107214;42899;42915.785421072695;12299.569515066929;12468.937655311665;12529.686757831127;12590.685232869067;12615.747685046248;9930.751731206778;9946.850797238047;10058.346207496636;10074.042965918372;10077.647282345082;10478.423686697304;10671.57313707443;11435.2567083141;11914.106442016884;12071;5030.673006254582;5055.443901170868;5074.112030394666;5093.108705976513;5099.490050994871;875.2604049578097;887.7913690282778;890.3544929925752;903.6927444668844;916.8808054952814;19292.4212273632;19913.800861991484;19949.700754488695;19970.70043949342;20167.49581260451;986.4229425785852;987.6098940918441;987.7777500062572;992.1715367667933;1010.1716592394166;10195.898041019494;10275.434851083113;10496.107830834311;10574.577016919236;10708.19688523364;176978;178659;178896;179211;179373;39618;39710.60289397127;39819;39834.60165398309;39863.20273594512;1222.9938850305691;1273.2424207596466;1275.1201670847086;1282.0320657903223;1297.6042307096238;18170.90914545419;18403.42352070738;19244.422667320003;19265.22939082421;20035.799642003392;30190.69809301879;30284;30343.696563034086;30348.544771827997;30392;177339;178112;178549;178629;178915.10542447204;27995.300117497227;28044.29889252785;28076;28197.43605127927;28214.576781348707;24992.87503562543;32528.51207231941;32619.510707339883;32962.50556241706;33848.1537961553;25157;25165.496690066462;25482.872585636953;25620.745542949757;26608.06871759479;24624;24812.52900000502;25213.87393063023;25292.36769080714;25622.359441013377;28533.571996419654;28838.42323153483;28867.711322886502;28882.566761499016;28925.7107428923;24421.633675495235;24561.140360087313;24592.508149836543;25105.24684259475;25234.116805911704;19409.902950485157;20546.79453205449;20588.69116963217;20660.380188594365;20799.216180278923 22:27:20 INFO - PID 30010 | |2;jquery.html;393.8818354493651;398.7169109931948;407.95512493625705;408.28550037434485;423.6970566045277;17295.74056389152;17881.284748610055;18669.813301866976;18678.78587891786;18736.90631546842;18073.1867065982;18365.357212497565;18441.53896152597;18635.1614177362;18659.813401865977;5472.808451704182;5534.584906132036;5551.916721249185;5598.076317407643;5622.971885140569;5425.728713564306;5616.382197958222;5616.943830561703;5625.015622266107;5626.831195064155;5357.08929481989;5479.589030822684;5522.91715624266;5593.944060559404;5594.328680558338;5439.129739241722;5479.287692599936;5519.061759500894;5519.39286678465;5524.226608274845;4813.951860481386;4841.685290456109;4854.490278520775;4854.951450485485;4918.778654960535;20790;20878.895605521877;20911.26810561623;20970;21091.367258982256;1670.3068226686032;1677.5973766296001;1693.2380428807087;1694.4747128390238;1698.422536337651;13984.300784960711;14094.718105637932;14173.78739318911;14294.070885392417;14322.427102915872;2046.9385918422472;2080.408487507043;2133.5092928626345;2133.8933053347428;2138.625740495407;78114.60942695307;78722.21277787206;78900.21099788987;79966.60016699937;80702;10125.443100629389;10271;10575.36547807134;10625.574977000988;10661.413622250851;14420.278986050656;14533.200673963034;14536.636584085483;14561.635959100895;14592.927035364968;7054.753083642048;7237.312455316736;7332.120145582564;7489.550626962399;7513.549187048795;6752.628605426748;6798.592084474947;6934.237233904267;6944.895826562605;6970.581765094111;6684.966575167093;6711.362420570038;6741.831454213684;6784.457243420613;6843.931560684429;1904.7142928560827;1907.6852319367426;1948.6067461764906;1959.7256384106236;1969.9606007879763;828.7099515169763;843.696269343036;849.7748096754365;867.6442658509981;879.7492714576443;15851.920740396456;16714.58213544671;16743;16912.408065717642;16932.915335423244;885.9911400885909;886.8758373827669;898.5641963647626;898.573177740568;915.190056799737;8778.542008237704;9168.81662366749;9175.678851240174;9246.722598322061;9323.533823308808;481764;486195;487499;489989;491137;73312;80151.59924200458;94958.52520737352;96379.51810240904;98042;971.3783178765595;1073.8979796919125;1110.245033377311;1114.8773634900153;1116.2465335898237;16449.25978330954;16553.917230413772;16907.746383804006;17382.304707811545;18007.279708812024;43034.78482607567;43379.78310108429;43997.94023687189;44386.55613443953;45098.0980380384;53155;54093.72953135209;54577.72711136419;55630.16554751763;55769.44230557805;7422.777316680508;7433.293837085468;7454;7468.4398670101045;7782.182870798485;11263.943680281875;11578.594749183738;11594.826077609012;11800.82298765502;12054.337011464453;9883.308168428428;10206.591736330463;10270.281080324306;10440.26918115755;10664.466776661291;9342.95328523353;10077.143442807443;10134.594616215269;10204.132648724644;10248.846267306146;10083.546240419051;10122.8481572775;10144.239182061227;10529.36823790575;10579.15366770672;7369.520981136209;7371.115466144097;7477.626118694152;7609.581473019037;7737.767866964;10037.297389182979;10123.89876101259;10136.949315253376;10186.745331366776;10487.475626218506 22:27:20 INFO - PID 30010 | |3;mootools.html;1289.3424353579674;1349.4534713441053;1352.7970804379347;1361.4418088583677;1371.122481611768;9704.902950970489;10144.391336519813;10155.847662285072;10161.441120738356;10161.644342448017;9961.2031037517;10309.381437113778;10311.175105991522;10315.58737650495;10316;2323.9883800581015;2355.5995480768224;2366.479374537599;2366.8106551475926;2372.833901626887;1928.3732786844262;2003.47909543519;2226.955460890781;2333.6966194394704;2342.2504798464497;2235.8770267635273;2322.686437330964;2326.7905888470036;2330.0446816805115;2331.172433786007;2219.3563866478703;2277.601419751545;2288.656701494781;2291.576058429196;2322.5354929014266;2246.8651880887037;2278.191242109044;2282.1898226129815;2282.8402011859175;2286;9907.702768916944;10127.442990635513;10137.189024878066;10167.847482287772;10175.643852465128;5702.45826646468;5905.4980326672285;5907.232059832238;5909.4090590941;5915.615484993462;3223.8549265282886;3380.3746306933294;3390.135515443571;3459.117924929152;3466.9479957800654;1022.8363461846069;1039.272509243525;1058.3649810113948;1077.6228320087985;1094.7646256054907;14911.776323355158;15030;15066.397344106223;15072;15072.397104115931;4596.678232523691;4768.260919557474;4992.15133427311;4995.700257984533;5086.338775959101;11060.834087488694;11062.612808551823;11089.944550277198;11098.167637427225;11103.38931358783;5710.914336284959;5722.055860782924;5730.426957304319;5730.713464326767;5739.885202295931;5165.845024649267;5183.5593974512585;5306.92039619406;5307.363116426053;5345.1714984177515;3785.2618739346112;3937.370020796659;3948.7235893487755;3998.280309544252;4043;1005.261133067195;1051.5688567687212;1164.9650510484698;1166.5042356998242;1180.144395313391;645.3514218210762;669.1267895396554;674.4402146218627;676.077154683853;688.3770187979886;5532.861678458071;5586.469285417878;5587.497125258747;5650.23721797552;5757.193992841006;525.8159644124526;562.5808772464541;564.5370795947366;568.8378812038632;667.9799606011827;3290.670932906738;3617.1680513482047;3627.782333060025;3638.7634803737674;3693.9445908311395;12872.871271287355;13536.864631353757;13548.458061677422;13568.796468052988;13571.1857288563;12941.805872911913;13397.397117129753;13400.128991615515;13408.329583520785;13424.865751342557;9414.340996130206;9559.61761529531;9635.807283854283;9637.18083962857;9638.662646807328;5461.726913654381;5489.752961116679;5521.199426083276;5546.278983732089;5657.632253903483;11812.822807658064;11834.82247766267;11870.287782733063;12023.21849079807;12089.75820483603;11784.175107742376;12079.818802718142;12246.203996740183;12261.754764904474;12267;8243.587820609066;8272.627731751965;8388.622511986854;8406.83186336282;8471.915280847114;8922.286217102486;9129.5891684873;9131.680391186277;9139.44629412988;9140;7981.92018079835;8123.75628731139;8128.837423251383;8272.33821294283;8374.581270936307;7680.5391676499585;7719.266669666373;7884.605769711607;7961.283484486424;7993.080795708568;7342.8898566520475;7345.816354591178;7372.668229929559;7427.405807535492;7454.552726836408;5085.694858308365;5176.145935920531;5202.297689811827;5232.921506177487;5289.259503669412;5054.09026375256;5054.772535235849;5117.543579081987;5279.47205279469;5284.233786101071 22:27:20 INFO - PID 30010 | |4;prototype.html;366.38630294257115;376.8662124945644;379.7626483447845;383.61063520526653;384.52703175094615;5345.812896548621;5346.919796203055;5360.115580929152;5365.543928766059;5397.91903121453;5060.949390506094;5202.739863006854;5256.973715131419;5265.9473405265935;5300.151975683892;4007.218592374481;4011.1777085697363;4011.879643610682;4013.8394464221396;4033.2336855997414;3977.741446805963;4005.118873847749;4010.4585880906143;4012.2577323195155;4020.356742921133;3863.3239183142978;3975.403689446577;3977.781222032787;3997.240524300388;4009.9799501002453;3938.601796362279;3978.6021397860272;3980.3631418972827;3988.4615576897036;3990.880273591797;3477.930441391183;3480.3735327641016;3485.7559970802054;3490.661256957844;3496.370653282408;4814.542618451242;5086.18621020635;5097.643164978453;5103.18349064148;5106.387233531963;4605.976970115162;4659.930101048487;4668.299755036738;4680.836170734008;4688.390509233812;5528.668279903219;5535.6955367454775;5579.302587176603;5595.468430499096;5608.691521966291;3793.4878791363367;3885.805709714531;3888.2891527727993;3893.552241492236;3898.6686131678557;5626.76211233528;5754.625949313281;5785.797497087582;5852.707364631751;5887.705614719247;3980.8407663693706;3981.5819338969573;3981.980090099531;3986.262541429787;3986.7807270600397;4030.314846476106;4042.0097076216516;4042.7372220805555;4043.0903046814233;4044.2518134145275;4441.666874984389;4538.523455037173;4652.767361631905;4774.427068751772;4851.296561998491;5608.6073974821375;5618.69097199658;5623.831285061373;5629.155626656035;5630.662160270315;1475.76387777955;1494.618872187607;1497.1466264229284;1497.4160077569757;1497.4983380567414;1038.4963292802984;1064.2869277584036;1072.110148576695;1072.4584085037006;1087.7273589899837;4874.268859671007;4884.95115048852;4889.657723959289;4892.363992680928;4900.656954013185;5774.249347584787;5776.104703770922;5785.392533783892;5788.652680839163;5789;4748.548887855648;4875.609951203895;4893.4617192108835;4899.804007839646;4908.410990681141;3028.9242768930953;3043.786934914579;3055.312554675225;3057.816531008102;3078.615173103362;5273.815416460482;5396.541293989976;5405.70268635221;5406.459354064562;5425.213344065168;5872.884152011105;5888.352281249059;5905.557083218776;5910.556708246899;5913.645181289136;5388.8113916013535;5389.434109418533;5402.6758394496455;5408.215808707637;5445.074337362737;5525.889482210414;5677.51741102011;5680.68756218412;5706.771729130788;5734.569907257056;5669.036263835075;5669.20631111653;5708.915306091829;5710.200571920018;5713.371529131709;5195.376554813447;5222.8955420892125;5298.947010529845;5323.760430780547;5400.513953744182;4192.496900371975;4193.517745459311;4201.138766552788;4225.66194704429;4241.681873859411;5552.916706249329;5700.600957932905;5724.8282551523525;5738.8278351649515;5759.280089988752;5555.111182210827;5572.60991730575;5575.972120139373;5583.274174357308;5585;5552.083906155601;5554.166874968787;5561.833145005657;5588.189712491585;5592.189132575835;5287.206918962186;5463.808766693147;5476.397596264487;5491.615586908878;5499.752511136929;5593.8042168525535;5607.607467477237;5609.102543593006;5610.8316750495915;5613.382527921844;5372.059889519241;5426.996005738951;5445.754941027584;5470.015397228537;5470.550304169319 22:27:20 INFO - PID 30010 | |5;yui.html;734.3354264390725;743.7657138001525;752.8795392737163;755.210804709079;767.4321002458181;12858.742825143492;13131;13417.262050587215;13428.932855335734;13434.59696209113;12295.139340246187;12534.435950382232;12535.749285014293;12538.81191782124;12788.104832661717;892.5269607108243;904.1500989070253;910.8497097978826;915.3592485260311;916.3448134583771;934.9948805034581;935.2658163341778;935.4387367579432;936.9250459963221;937.1986951156765;965.1844191658038;965.6861520006026;965.7102869139266;965.7344230336644;966.5843687214496;955.3551352836807;957.238994998974;958.4584709639032;960.1262850805733;963.8891527474325;706.9116360454943;712.0778591723679;712.5154894671621;713.375796178344;714.9642517874086;13692.863071369358;13891;14051.859481405158;14069.859301406957;14084.15495070299;12430.937845310715;13160.341982900816;13371.130876493095;13398.665033374145;13489.932550337284;11414.258073225214;11659.766804663945;11763.529458821637;11771;11868.821967670492;2851.0876519513763;2858.4568931902872;2866.2977570495154;2883.5818806272973;2889.0754958413318;70000.2999970004;70529.6473517629;70532;72330;72928;11102.999999999838;11110.666679999613;11137.51379512629;11153.665390038312;11497.885021149848;21355.8932205338;21566.245181418573;21579.13683452644;21597.572497637946;21641.56716865654;5546.639468434539;5698.230738850285;5755.840323778486;5801.767929282782;5816;2840.176348858849;2850.8717107730204;2871.5118429866975;2971.6731159572428;2979.031814660244;3520.823958802101;3613.2050948791225;3644.526211592529;3645.4714066460215;3648.7263455240964;644.1851058411114;650.4698670583459;654.2639530528156;656.8981807819796;657.4477438951304;508.62870104822946;511.40166005773335;519.8310549071567;522.276646844116;525.8711615654189;7410.703571857065;7652.349550288177;7675.15573286938;7800;7867.527948323119;521.0984995957016;523.9004589128053;527.6069328350403;531.4871149340827;540.8593765620889;3474.2009337851932;3514.086337552255;3551.964480355215;3558.665500437336;3731.2910546995986;57701.71149144227;59262.40737592655;59852.40147598468;62303.37696622976;62305.688471557354;52147.73926130345;52741.208881866805;52992.73503632457;53019;54355.72822135943;35124.82437587796;46653;48502.757486212344;49245.75377123091;49454;9115.544222788967;9448.763780905532;9592.66425675098;9598.136167744937;9636.132748052709;27111.59332610052;27181.72818271792;27526.587101193098;27617.309567260978;27773.583396249476;32225.355492889543;32327.191820204684;32428.675713242566;32679.346413072082;33719.66280337263;10376.948115259376;10390.636327728796;10541.78916421652;10591.682249532527;10796.190285728444;10419.843702344318;10422.635207767995;10423.635172768916;10454.215933804842;10479.68560943173;11964.341961192218;11979.161458697807;11993.220440671328;12109.757804843677;12110.697232569257;11279.9213028748;11656.475458604553;11723.35521546289;11905.880941190824;12133.575324863587;11798.196586928776;11972.281663100242;12099.758004839678;12197;12882.355882205664;9397.906020939703;9755.170810481188;9816.754581135528;9827.606895724091;9938.503074846085;9502;9986.800263994824;10043.347182433119;10050.447225402673;10129.290949633749 22:27:20 INFO - PID 30010 | __end_tp_report 22:27:20 INFO - PID 30010 | __start_cc_report 22:27:20 INFO - PID 30010 | _x_x_mozilla_cycle_collect,1285 22:27:20 INFO - PID 30010 | __end_cc_report 22:27:20 INFO - PID 30010 | __startTimestamp1491456440473__endTimestamp 22:27:20 INFO - PID 30010 | 22:27:20 INFO - PID 30010 | ------- Summary: start ------- 22:27:20 INFO - PID 30010 | Number of tests: 6 22:27:20 INFO - PID 30010 | 22:27:20 INFO - PID 30010 | [#0] dojo.html Cycles:165 Average:5230.84 Median:5412.57 stddev:618.47 (11.4%) stddev-sans-first:588.54 22:27:20 INFO - PID 30010 | Values: 2734.4 2758.2 2799.4 2802.4 2817.4 5118.9 5250.4 5273.7 5307.3 5347.9 5242.7 5243.2 5263.9 5265.4 5271.5 4669.9 4699.6 4732.0 4735.7 4769.7 4706.6 4742.8 4749.5 4750.9 4751.6 4742.3 4749.1 4753.1 4759.0 4782.1 4765.0 4797.6 4801.1 4801.4 4829.7 4737.2 4777.7 4780.3 4780.7 4814.3 4768.9 4941.5 5121.1 5204.7 5270.3 5599.2 5690.8 5695.4 5696.9 5701.5 5795.6 5824.6 5842.6 5843.1 5844.6 5357.2 5363.1 5370.8 5373.5 5373.9 5741.4 5912.8 5914.7 5916.0 5934.1 5473.8 5604.3 5672.3 5677.8 5691.8 5747.6 5765.8 5766.1 5766.8 5767.8 5682.4 5727.0 5735.3 5738.7 5742.9 5520.9 5602.6 5605.1 5714.2 5760.9 4725.3 4769.0 4778.8 4786.0 4801.9 4052.6 4057.6 4060.2 4064.7 4090.3 4842.2 4847.7 4853.2 4855.1 4888.6 5617.9 5628.7 5684.5 5693.7 5697.3 4810.0 4816.7 4819.9 4822.7 4824.1 5029.6 5056.8 5058.5 5070.4 5079.1 5313.2 5318.2 5326.1 5363.5 5425.2 5800.2 5805.4 5806.9 5818.9 5861.6 5398.3 5408.9 5412.1 5412.6 5412.8 5491.6 5565.4 5570.0 5683.4 5688.7 5745.7 5780.5 5813.4 5827.4 5836.1 5553.3 5561.1 5561.5 5564.6 5566.7 5428.4 5587.7 5601.4 5604.7 5605.0 5426.4 5443.7 5473.2 5518.3 5533.9 5635.0 5649.8 5651.1 5652.8 5654.5 5469.9 5478.5 5485.3 5485.5 5488.6 22:27:20 INFO - PID 30010 | 22:27:20 INFO - PID 30010 | [#1] ext.html Cycles:180 Average:29864.63 Median:28206.01 stddev:42685.29 (151.3%) stddev-sans-first:42748.75 22:27:20 INFO - PID 30010 | Values: 672.5 718.0 739.5 1074.1 1093.4 26117.3 26724.0 26726.9 26757.0 26758.1 33050.7 33526.7 33559.0 33579.7 33625.7 7205.6 7341.9 7346.6 7351.7 7358.2 5497.8 5644.6 7213.0 7317.9 7323.2 7043.5 7264.3 7272.0 7291.8 7292.0 7274.6 7336.3 7341.6 7344.0 7346.1 5379.3 5566.9 5573.9 7160.5 7241.6 24468.6 30405.5 30730.5 30931.5 30952.8 2961.7 2992.3 2997.6 2998.8 2999.2 24109.4 24191.2 24305.0 24329.1 24404.5 2734.2 2760.5 2776.1 2799.1 2880.4 133280.0 133559.0 133718.3 133752.0 133938.0 40838.6 40873.4 40916.6 40930.6 40950.8 42459.2 42847.8 42893.8 42899.0 42915.8 12299.6 12468.9 12529.7 12590.7 12615.7 9930.8 9946.9 10058.3 10074.0 10077.6 10478.4 10671.6 11435.3 11914.1 12071.0 5030.7 5055.4 5074.1 5093.1 5099.5 875.3 887.8 890.4 903.7 916.9 19292.4 19913.8 19949.7 19970.7 20167.5 986.4 987.6 987.8 992.2 1010.2 10195.9 10275.4 10496.1 10574.6 10708.2 176978.0 178659.0 178896.0 179211.0 179373.0 39618.0 39710.6 39819.0 39834.6 39863.2 1223.0 1273.2 1275.1 1282.0 1297.6 18170.9 18403.4 19244.4 19265.2 20035.8 30190.7 30284.0 30343.7 30348.5 30392.0 177339.0 178112.0 178549.0 178629.0 178915.1 27995.3 28044.3 28076.0 28197.4 28214.6 24992.9 32528.5 32619.5 32962.5 33848.2 25157.0 25165.5 25482.9 25620.7 26608.1 24624.0 24812.5 25213.9 25292.4 25622.4 28533.6 28838.4 28867.7 28882.6 28925.7 24421.6 24561.1 24592.5 25105.2 25234.1 19409.9 20546.8 20588.7 20660.4 20799.2 22:27:20 INFO - PID 30010 | 22:27:20 INFO - PID 30010 | [#2] jquery.html Cycles:180 Average:28271.73 Median:44742.33 stddev:80348.69 (179.6%) stddev-sans-first:80546.82 22:27:20 INFO - PID 30010 | Values: 393.9 398.7 408.0 408.3 423.7 17295.7 17881.3 18669.8 18678.8 18736.9 18073.2 18365.4 18441.5 18635.2 18659.8 5472.8 5534.6 5551.9 5598.1 5623.0 5425.7 5616.4 5616.9 5625.0 5626.8 5357.1 5479.6 5522.9 5593.9 5594.3 5439.1 5479.3 5519.1 5519.4 5524.2 4814.0 4841.7 4854.5 4855.0 4918.8 20790.0 20878.9 20911.3 20970.0 21091.4 1670.3 1677.6 1693.2 1694.5 1698.4 13984.3 14094.7 14173.8 14294.1 14322.4 2046.9 2080.4 2133.5 2133.9 2138.6 78114.6 78722.2 78900.2 79966.6 80702.0 10125.4 10271.0 10575.4 10625.6 10661.4 14420.3 14533.2 14536.6 14561.6 14592.9 7054.8 7237.3 7332.1 7489.6 7513.5 6752.6 6798.6 6934.2 6944.9 6970.6 6685.0 6711.4 6741.8 6784.5 6843.9 1904.7 1907.7 1948.6 1959.7 1970.0 828.7 843.7 849.8 867.6 879.7 15851.9 16714.6 16743.0 16912.4 16932.9 886.0 886.9 898.6 898.6 915.2 8778.5 9168.8 9175.7 9246.7 9323.5 481764.0 486195.0 487499.0 489989.0 491137.0 73312.0 80151.6 94958.5 96379.5 98042.0 971.4 1073.9 1110.2 1114.9 1116.2 16449.3 16553.9 16907.7 17382.3 18007.3 43034.8 43379.8 43997.9 44386.6 45098.1 53155.0 54093.7 54577.7 55630.2 55769.4 7422.8 7433.3 7454.0 7468.4 7782.2 11263.9 11578.6 11594.8 11800.8 12054.3 9883.3 10206.6 10270.3 10440.3 10664.5 9343.0 10077.1 10134.6 10204.1 10248.8 10083.5 10122.8 10144.2 10529.4 10579.2 7369.5 7371.1 7477.6 7609.6 7737.8 10037.3 10123.9 10136.9 10186.7 10487.5 22:27:20 INFO - PID 30010 | 22:27:20 INFO - PID 30010 | [#3] mootools.html Cycles:180 Average:6335.13 Median:3666.35 stddev:4066.36 (110.9%) stddev-sans-first:4060.09 22:27:20 INFO - PID 30010 | Values: 1289.3 1349.5 1352.8 1361.4 1371.1 9704.9 10144.4 10155.8 10161.4 10161.6 9961.2 10309.4 10311.2 10315.6 10316.0 2324.0 2355.6 2366.5 2366.8 2372.8 1928.4 2003.5 2227.0 2333.7 2342.3 2235.9 2322.7 2326.8 2330.0 2331.2 2219.4 2277.6 2288.7 2291.6 2322.5 2246.9 2278.2 2282.2 2282.8 2286.0 9907.7 10127.4 10137.2 10167.8 10175.6 5702.5 5905.5 5907.2 5909.4 5915.6 3223.9 3380.4 3390.1 3459.1 3466.9 1022.8 1039.3 1058.4 1077.6 1094.8 14911.8 15030.0 15066.4 15072.0 15072.4 4596.7 4768.3 4992.2 4995.7 5086.3 11060.8 11062.6 11089.9 11098.2 11103.4 5710.9 5722.1 5730.4 5730.7 5739.9 5165.8 5183.6 5306.9 5307.4 5345.2 3785.3 3937.4 3948.7 3998.3 4043.0 1005.3 1051.6 1165.0 1166.5 1180.1 645.4 669.1 674.4 676.1 688.4 5532.9 5586.5 5587.5 5650.2 5757.2 525.8 562.6 564.5 568.8 668.0 3290.7 3617.2 3627.8 3638.8 3693.9 12872.9 13536.9 13548.5 13568.8 13571.2 12941.8 13397.4 13400.1 13408.3 13424.9 9414.3 9559.6 9635.8 9637.2 9638.7 5461.7 5489.8 5521.2 5546.3 5657.6 11812.8 11834.8 11870.3 12023.2 12089.8 11784.2 12079.8 12246.2 12261.8 12267.0 8243.6 8272.6 8388.6 8406.8 8471.9 8922.3 9129.6 9131.7 9139.4 9140.0 7981.9 8123.8 8128.8 8272.3 8374.6 7680.5 7719.3 7884.6 7961.3 7993.1 7342.9 7345.8 7372.7 7427.4 7454.6 5085.7 5176.1 5202.3 5232.9 5289.3 5054.1 5054.8 5117.5 5279.5 5284.2 22:27:20 INFO - PID 30010 | 22:27:20 INFO - PID 30010 | [#4] prototype.html Cycles:180 Average:4601.39 Median:5150.88 stddev:1336.19 (25.9%) stddev-sans-first:1301.58 22:27:20 INFO - PID 30010 | Values: 366.4 376.9 379.8 383.6 384.5 5345.8 5346.9 5360.1 5365.5 5397.9 5060.9 5202.7 5257.0 5265.9 5300.2 4007.2 4011.2 4011.9 4013.8 4033.2 3977.7 4005.1 4010.5 4012.3 4020.4 3863.3 3975.4 3977.8 3997.2 4010.0 3938.6 3978.6 3980.4 3988.5 3990.9 3477.9 3480.4 3485.8 3490.7 3496.4 4814.5 5086.2 5097.6 5103.2 5106.4 4606.0 4659.9 4668.3 4680.8 4688.4 5528.7 5535.7 5579.3 5595.5 5608.7 3793.5 3885.8 3888.3 3893.6 3898.7 5626.8 5754.6 5785.8 5852.7 5887.7 3980.8 3981.6 3982.0 3986.3 3986.8 4030.3 4042.0 4042.7 4043.1 4044.3 4441.7 4538.5 4652.8 4774.4 4851.3 5608.6 5618.7 5623.8 5629.2 5630.7 1475.8 1494.6 1497.1 1497.4 1497.5 1038.5 1064.3 1072.1 1072.5 1087.7 4874.3 4885.0 4889.7 4892.4 4900.7 5774.2 5776.1 5785.4 5788.7 5789.0 4748.5 4875.6 4893.5 4899.8 4908.4 3028.9 3043.8 3055.3 3057.8 3078.6 5273.8 5396.5 5405.7 5406.5 5425.2 5872.9 5888.4 5905.6 5910.6 5913.6 5388.8 5389.4 5402.7 5408.2 5445.1 5525.9 5677.5 5680.7 5706.8 5734.6 5669.0 5669.2 5708.9 5710.2 5713.4 5195.4 5222.9 5298.9 5323.8 5400.5 4192.5 4193.5 4201.1 4225.7 4241.7 5552.9 5700.6 5724.8 5738.8 5759.3 5555.1 5572.6 5576.0 5583.3 5585.0 5552.1 5554.2 5561.8 5588.2 5592.2 5287.2 5463.8 5476.4 5491.6 5499.8 5593.8 5607.6 5609.1 5610.8 5613.4 5372.1 5427.0 5445.8 5470.0 5470.6 22:27:20 INFO - PID 30010 | 22:27:20 INFO - PID 30010 | [#5] yui.html Cycles:180 Average:14091.01 Median:3645.00 stddev:17397.24 (477.3%) stddev-sans-first:17417.13 22:27:20 INFO - PID 30010 | Values: 734.3 743.8 752.9 755.2 767.4 12858.7 13131.0 13417.3 13428.9 13434.6 12295.1 12534.4 12535.7 12538.8 12788.1 892.5 904.2 910.8 915.4 916.3 935.0 935.3 935.4 936.9 937.2 965.2 965.7 965.7 965.7 966.6 955.4 957.2 958.5 960.1 963.9 706.9 712.1 712.5 713.4 715.0 13692.9 13891.0 14051.9 14069.9 14084.2 12430.9 13160.3 13371.1 13398.7 13489.9 11414.3 11659.8 11763.5 11771.0 11868.8 2851.1 2858.5 2866.3 2883.6 2889.1 70000.3 70529.6 70532.0 72330.0 72928.0 11103.0 11110.7 11137.5 11153.7 11497.9 21355.9 21566.2 21579.1 21597.6 21641.6 5546.6 5698.2 5755.8 5801.8 5816.0 2840.2 2850.9 2871.5 2971.7 2979.0 3520.8 3613.2 3644.5 3645.5 3648.7 644.2 650.5 654.3 656.9 657.4 508.6 511.4 519.8 522.3 525.9 7410.7 7652.3 7675.2 7800.0 7867.5 521.1 523.9 527.6 531.5 540.9 3474.2 3514.1 3552.0 3558.7 3731.3 57701.7 59262.4 59852.4 62303.4 62305.7 52147.7 52741.2 52992.7 53019.0 54355.7 35124.8 46653.0 48502.8 49245.8 49454.0 9115.5 9448.8 9592.7 9598.1 9636.1 27111.6 27181.7 27526.6 27617.3 27773.6 32225.4 32327.2 32428.7 32679.3 33719.7 10376.9 10390.6 10541.8 10591.7 10796.2 10419.8 10422.6 10423.6 10454.2 10479.7 11964.3 11979.2 11993.2 12109.8 12110.7 11279.9 11656.5 11723.4 11905.9 12133.6 11798.2 11972.3 12099.8 12197.0 12882.4 9397.9 9755.2 9816.8 9827.6 9938.5 9502.0 9986.8 10043.3 10050.4 10129.3 22:27:20 INFO - PID 30010 | -------- Summary: end -------- 22:27:20 INFO - PID 30010 | 22:27:21 INFO - TEST-INFO | 30010: exit 0 22:27:21 INFO - TEST-OK | dromaeo_css | took 1124763ms 22:27:21 INFO - TEST-START | kraken 22:27:21 INFO - operating with platform_type : linux_ 22:27:21 INFO - Initialising browser for kraken test... 22:27:21 INFO - TEST-INFO | started process 30343 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpebA_LL/profile http://localhost:38956/getInfo.html) 22:27:25 INFO - PID 30343 | __metrics Screen width/height:1600/1200 22:27:25 INFO - PID 30343 | colorDepth:24 22:27:25 INFO - PID 30343 | Browser inner width/height: 1024/697 22:27:25 INFO - PID 30343 | __metrics 22:27:26 INFO - PID 30343 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:27:26 INFO - PID 30343 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 304: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:27:27 INFO - TEST-INFO | 30343: exit 0 22:27:27 INFO - Browser initialized. 22:27:27 INFO - Running cycle 1/1 for kraken test... 22:27:27 INFO - TEST-INFO | started process 30441 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpebA_LL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:27:40 INFO - PID 30441 | RSS: Main: 171491328 22:27:40 INFO - PID 30441 | 22:27:43 INFO - PID 30441 | Cycle 1(1): loaded http://localhost:38956/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38956/tests/kraken/driver.html?testName=audio-beat-detection) 22:27:44 INFO - PID 30441 | RSS: Main: 231645184 22:27:44 INFO - PID 30441 | 22:27:46 INFO - PID 30441 | Cycle 1(1): loaded http://localhost:38956/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38956/tests/kraken/driver.html?testName=audio-dft) 22:27:47 INFO - PID 30441 | RSS: Main: 210759680 22:27:47 INFO - PID 30441 | 22:27:50 INFO - PID 30441 | Cycle 1(1): loaded http://localhost:38956/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38956/tests/kraken/driver.html?testName=audio-fft) 22:27:51 INFO - PID 30441 | RSS: Main: 294666240 22:27:51 INFO - PID 30441 | 22:27:53 INFO - PID 30441 | Cycle 1(1): loaded http://localhost:38956/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38956/tests/kraken/driver.html?testName=audio-oscillator) 22:27:53 INFO - PID 30441 | RSS: Main: 206241792 22:27:53 INFO - PID 30441 | 22:27:56 INFO - PID 30441 | Cycle 1(1): loaded http://localhost:38956/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38956/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:27:56 INFO - PID 30441 | RSS: Main: 210096128 22:27:56 INFO - PID 30441 | 22:27:59 INFO - PID 30441 | Cycle 1(1): loaded http://localhost:38956/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38956/tests/kraken/driver.html?testName=imaging-darkroom) 22:28:00 INFO - PID 30441 | RSS: Main: 247570432 22:28:00 INFO - PID 30441 | 22:28:04 INFO - PID 30441 | Cycle 1(1): loaded http://localhost:38956/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38956/tests/kraken/driver.html?testName=imaging-desaturate) 22:28:04 INFO - PID 30441 | RSS: Main: 240590848 22:28:04 INFO - PID 30441 | 22:28:07 INFO - PID 30441 | Cycle 1(1): loaded http://localhost:38956/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38956/tests/kraken/driver.html?testName=json-parse-financial) 22:28:08 INFO - PID 30441 | RSS: Main: 243064832 22:28:08 INFO - PID 30441 | 22:28:10 INFO - PID 30441 | Cycle 1(1): loaded http://localhost:38956/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38956/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:28:10 INFO - PID 30441 | RSS: Main: 208003072 22:28:10 INFO - PID 30441 | 22:28:12 INFO - PID 30441 | Cycle 1(1): loaded http://localhost:38956/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38956/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:28:13 INFO - PID 30441 | RSS: Main: 216776704 22:28:13 INFO - PID 30441 | 22:28:15 INFO - PID 30441 | Cycle 1(1): loaded http://localhost:38956/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38956/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:28:15 INFO - PID 30441 | RSS: Main: 223666176 22:28:15 INFO - PID 30441 | 22:28:18 INFO - PID 30441 | Cycle 1(1): loaded http://localhost:38956/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38956/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:28:19 INFO - PID 30441 | RSS: Main: 231313408 22:28:19 INFO - PID 30441 | 22:28:22 INFO - PID 30441 | Cycle 1(1): loaded http://localhost:38956/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38956/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:28:23 INFO - PID 30441 | RSS: Main: 229797888 22:28:23 INFO - PID 30441 | 22:28:25 INFO - PID 30441 | Cycle 1(1): loaded http://localhost:38956/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38956/tests/kraken/driver.html?testName=ai-astar) 22:28:25 INFO - PID 30441 | RSS: Main: 297496576 22:28:25 INFO - PID 30441 | 22:28:25 INFO - PID 30441 | __start_tp_report 22:28:25 INFO - PID 30441 | _x_x_mozilla_page_load 22:28:25 INFO - PID 30441 | _x_x_mozilla_page_load_details 22:28:25 INFO - PID 30441 | |i|pagename|runs| 22:28:25 INFO - PID 30441 | |0;ai-astar;108;113;112;112;112;114;113;112;112;112 22:28:25 INFO - PID 30441 | |1;audio-beat-detection;155;125;129;162;124;123;122;132;145;123 22:28:25 INFO - PID 30441 | |2;audio-dft;164;165;165;165;165;165;163;165;162;163 22:28:25 INFO - PID 30441 | |3;audio-fft;74;74;75;112;79;76;76;75;91;75 22:28:25 INFO - PID 30441 | |4;audio-oscillator;83;85;106;83;84;83;106;84;84;106 22:28:25 INFO - PID 30441 | |5;imaging-gaussian-blur;114;114;113;113;113;114;114;114;114;114 22:28:25 INFO - PID 30441 | |6;imaging-darkroom;151;151;151;151;150;151;151;151;152;151 22:28:25 INFO - PID 30441 | |7;imaging-desaturate;95;96;94;94;95;95;95;94;111;95 22:28:25 INFO - PID 30441 | |8;json-parse-financial;54;52;52;54;53;54;55;54;54;53 22:28:25 INFO - PID 30441 | |9;json-stringify-tinderbox;56;57;57;56;56;56;57;56;56;62 22:28:25 INFO - PID 30441 | |10;stanford-crypto-aes;84;82;83;83;88;82;83;83;83;83 22:28:25 INFO - PID 30441 | |11;stanford-crypto-ccm;136;133;134;132;133;139;134;135;182;138 22:28:25 INFO - PID 30441 | |12;stanford-crypto-pbkdf2;182;191;192;192;191;191;194;195;194;192 22:28:25 INFO - PID 30441 | |13;stanford-crypto-sha256-iterative;75;71;72;74;74;69;70;69;70;71 22:28:25 INFO - PID 30441 | __end_tp_report 22:28:25 INFO - PID 30441 | __start_cc_report 22:28:25 INFO - PID 30441 | _x_x_mozilla_cycle_collect,1974 22:28:25 INFO - PID 30441 | __end_cc_report 22:28:25 INFO - PID 30441 | __startTimestamp1491456505316__endTimestamp 22:28:25 INFO - PID 30441 | 22:28:25 INFO - PID 30441 | ------- Summary: start ------- 22:28:25 INFO - PID 30441 | Number of tests: 14 22:28:25 INFO - PID 30441 | 22:28:25 INFO - PID 30441 | [#0] ai-astar Cycles:10 Average:112.00 Median:112.00 stddev:1.56 (1.4%) stddev-sans-first:0.73 22:28:25 INFO - PID 30441 | Values: 108.0 113.0 112.0 112.0 112.0 114.0 113.0 112.0 112.0 112.0 22:28:25 INFO - PID 30441 | 22:28:25 INFO - PID 30441 | [#1] audio-beat-detection Cycles:10 Average:134.00 Median:130.50 stddev:14.69 (11.3%) stddev-sans-first:13.47 22:28:25 INFO - PID 30441 | Values: 155.0 125.0 129.0 162.0 124.0 123.0 122.0 132.0 145.0 123.0 22:28:25 INFO - PID 30441 | 22:28:25 INFO - PID 30441 | [#2] audio-dft Cycles:10 Average:164.20 Median:165.00 stddev:1.14 (0.7%) stddev-sans-first:1.20 22:28:25 INFO - PID 30441 | Values: 164.0 165.0 165.0 165.0 165.0 165.0 163.0 165.0 162.0 163.0 22:28:25 INFO - PID 30441 | 22:28:25 INFO - PID 30441 | [#3] audio-fft Cycles:10 Average:80.70 Median:75.50 stddev:12.11 (16.0%) stddev-sans-first:12.60 22:28:25 INFO - PID 30441 | Values: 74.0 74.0 75.0 112.0 79.0 76.0 76.0 75.0 91.0 75.0 22:28:25 INFO - PID 30441 | 22:28:25 INFO - PID 30441 | [#4] audio-oscillator Cycles:10 Average:90.40 Median:83.50 stddev:10.78 (12.9%) stddev-sans-first:11.10 22:28:25 INFO - PID 30441 | Values: 83.0 85.0 106.0 83.0 84.0 83.0 106.0 84.0 84.0 106.0 22:28:25 INFO - PID 30441 | 22:28:25 INFO - PID 30441 | [#5] imaging-gaussian-blur Cycles:10 Average:113.70 Median:114.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 22:28:25 INFO - PID 30441 | Values: 114.0 114.0 113.0 113.0 113.0 114.0 114.0 114.0 114.0 114.0 22:28:25 INFO - PID 30441 | 22:28:25 INFO - PID 30441 | [#6] imaging-darkroom Cycles:10 Average:151.00 Median:151.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 22:28:25 INFO - PID 30441 | Values: 151.0 151.0 151.0 151.0 150.0 151.0 151.0 151.0 152.0 151.0 22:28:25 INFO - PID 30441 | 22:28:25 INFO - PID 30441 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:95.00 stddev:5.17 (5.4%) stddev-sans-first:5.46 22:28:25 INFO - PID 30441 | Values: 95.0 96.0 94.0 94.0 95.0 95.0 95.0 94.0 111.0 95.0 22:28:25 INFO - PID 30441 | 22:28:25 INFO - PID 30441 | [#8] json-parse-financial Cycles:10 Average:53.50 Median:54.00 stddev:0.97 (1.8%) stddev-sans-first:1.01 22:28:25 INFO - PID 30441 | Values: 54.0 52.0 52.0 54.0 53.0 54.0 55.0 54.0 54.0 53.0 22:28:25 INFO - PID 30441 | 22:28:25 INFO - PID 30441 | [#9] json-stringify-tinderbox Cycles:10 Average:56.90 Median:56.50 stddev:1.85 (3.3%) stddev-sans-first:1.94 22:28:25 INFO - PID 30441 | Values: 56.0 57.0 57.0 56.0 56.0 56.0 57.0 56.0 56.0 62.0 22:28:25 INFO - PID 30441 | 22:28:25 INFO - PID 30441 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:83.00 stddev:1.71 (2.1%) stddev-sans-first:1.80 22:28:25 INFO - PID 30441 | Values: 84.0 82.0 83.0 83.0 88.0 82.0 83.0 83.0 83.0 83.0 22:28:25 INFO - PID 30441 | 22:28:25 INFO - PID 30441 | [#11] stanford-crypto-ccm Cycles:10 Average:139.60 Median:135.50 stddev:15.06 (11.1%) stddev-sans-first:15.92 22:28:25 INFO - PID 30441 | Values: 136.0 133.0 134.0 132.0 133.0 139.0 134.0 135.0 182.0 138.0 22:28:25 INFO - PID 30441 | 22:28:25 INFO - PID 30441 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:191.40 Median:192.00 stddev:3.60 (1.9%) stddev-sans-first:1.51 22:28:25 INFO - PID 30441 | Values: 182.0 191.0 192.0 192.0 191.0 191.0 194.0 195.0 194.0 192.0 22:28:25 INFO - PID 30441 | 22:28:25 INFO - PID 30441 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.50 Median:71.50 stddev:2.17 (3.0%) stddev-sans-first:1.90 22:28:25 INFO - PID 30441 | Values: 75.0 71.0 72.0 74.0 74.0 69.0 70.0 69.0 70.0 71.0 22:28:25 INFO - PID 30441 | -------- Summary: end -------- 22:28:25 INFO - PID 30441 | 22:28:26 INFO - TEST-INFO | 30441: exit 0 22:28:26 INFO - TEST-OK | kraken | took 65367ms 22:28:26 INFO - SUITE-END | took 1190s 22:28:26 INFO - Completed test suite (00:19:50) 22:28:26 INFO - javascript benchmark 22:28:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6552.392226074393, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2734.3984323448835, 2758.241483592011, 2799.3561480859403, 2802.3974845408234, 2817.422428402177, 5118.897622047557, 5250.396204436491, 5273.736313184339, 5307.256984022235, 5347.919781203285, 5242.737863106839, 5243.239730239113, 5263.921041184385, 5265.394479634843, 5271.525562699357, 4669.906601867969, 4699.647526435514, 4731.9763401182945, 4735.668503204777, 4769.713817170964, 4706.647001474886, 4742.834000809972, 4749.525047495257, 4750.857474275777, 4751.643626727992, 4742.33607294979, 4749.121412538691, 4753.144434001878, 4759.024399998009, 4782.1153086678905, 4764.97617511912, 4797.592204662608, 4801.063792560452, 4801.375821143229, 4829.6860704054125, 4737.170995075848, 4777.689450185761, 4780.259059845729, 4780.713157210544, 4814.253790662453, 4768.928466073012, 4941.505849415065, 5121.129408000612, 5204.68771873685, 5270.288511050997, 5599.216109744639, 5690.800821971211, 5695.373508914016, 5696.857578560528, 5701.458361455655, 5795.594308398414, 5824.563157763142, 5842.591018628697, 5843.094320380348, 5844.590878638497, 5357.196420536911, 5363.115086010765, 5370.838874833761, 5373.516383525423, 5373.946260537345, 5741.397153298927, 5912.793052243151, 5914.733836977261, 5916.0, 5934.109883517507, 5473.8357849264585, 5604.327480702342, 5672.319321681342, 5677.829665110054, 5691.772329106872, 5747.626404283708, 5765.769369225184, 5766.106253530709, 5766.769329226868, 5767.826965191051, 5682.431756824284, 5727.0, 5735.340435849847, 5738.68437235956, 5742.856428589319, 5520.889582208333, 5602.607817452821, 5605.131204663284, 5714.200011998323, 5760.855978600484, 4725.267583524559, 4769.046190761862, 4778.832740854123, 4785.9760701196965, 4801.855944321676, 4052.615001574846, 4057.634812866856, 4060.1879624075304, 4064.7154699171365, 4090.3250963590676, 4842.225243960949, 4847.684900481458, 4853.247746599282, 4855.077535268288, 4888.608911287089, 5617.9438205618235, 5628.71856407178, 5684.54523638108, 5693.715314234271, 5697.3448053474385, 4810.013947140827, 4816.723568254415, 4819.903601927942, 4822.734749588736, 4824.131656301899, 5029.64792464524, 5056.797728090835, 5058.519440653132, 5070.366204224472, 5079.08576456234, 5313.1764576490705, 5318.228856815663, 5326.067938110893, 5363.463653634605, 5425.213344065168, 5800.187973683604, 5805.390434004369, 5806.854828629318, 5818.883622327615, 5861.6189947653265, 5398.325209348832, 5408.891822163613, 5412.079946409041, 5412.566994640498, 5412.78348866041, 5491.588130890119, 5565.359983601776, 5570.0, 5683.431656834284, 5688.744006519633, 5745.712714364181, 5780.537556995514, 5813.3605303417435, 5827.446392592697, 5836.095405212199, 5553.305836770403, 5561.054620714569, 5561.499465048003, 5564.610477266552, 5566.749496272759, 5428.430014848384, 5587.664740115606, 5601.383847776659, 5604.6917419542315, 5605.0, 5426.403095659395, 5443.700596467233, 5473.151661492475, 5518.255035570147, 5533.861653458695, 5634.971825141012, 5649.7740090397565, 5651.095824668033, 5652.7738890443925, 5654.547636189177, 5469.917951230815, 5478.45215478449, 5485.286912701324, 5485.451454854483, 5488.643238189505], "value": 5186.0188680022075, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [672.549391907422, 717.9533330333528, 739.5230076600593, 1074.129954736663, 1093.4478088565274, 26117.347066323353, 26724.0, 26726.866365668193, 26757.0, 26758.12007258949, 33050.66949330506, 33526.664733352656, 33559.0, 33579.664203357956, 33625.66374336256, 7205.639718014091, 7341.8898716519025, 7346.632668366587, 7351.669174887116, 7358.153812311599, 5497.835064948058, 5644.604877658566, 7213.0, 7317.926820731805, 7323.194448610649, 7043.471739619549, 7264.309890560388, 7271.963640181792, 7291.781246562585, 7292.0, 7274.563526188419, 7336.339729424378, 7341.632918354061, 7344.0, 7346.118465784113, 5379.273798037254, 5566.944330556683, 5573.8606534836545, 7160.498765086446, 7241.637918104074, 24468.632970505278, 30405.543916841267, 30730.539041914388, 30931.536026959613, 30952.8452357739, 2961.748251398612, 2992.2668946108342, 2997.640283166034, 2998.8050776699447, 2999.1902186409548, 24109.397265068514, 24191.15330963408, 24305.0, 24329.148479803123, 24404.511909761884, 2734.220747087071, 2760.489309477753, 2776.0977682253347, 2799.1042866282796, 2880.4095160492047, 133280.0, 133559.0, 133718.33140834235, 133752.0, 133938.0, 40838.59161408407, 40873.386899196536, 40916.590834091876, 40930.59069409328, 40950.795246023576, 42459.150816983485, 42847.78576107162, 42893.78553107214, 42899.0, 42915.785421072695, 12299.569515066929, 12468.937655311665, 12529.686757831127, 12590.685232869067, 12615.747685046248, 9930.751731206778, 9946.850797238047, 10058.346207496636, 10074.042965918372, 10077.647282345082, 10478.423686697304, 10671.57313707443, 11435.2567083141, 11914.106442016884, 12071.0, 5030.673006254582, 5055.443901170868, 5074.112030394666, 5093.108705976513, 5099.490050994871, 875.2604049578097, 887.7913690282778, 890.3544929925752, 903.6927444668844, 916.8808054952814, 19292.4212273632, 19913.800861991484, 19949.700754488695, 19970.70043949342, 20167.49581260451, 986.4229425785852, 987.6098940918441, 987.7777500062572, 992.1715367667933, 1010.1716592394166, 10195.898041019494, 10275.434851083113, 10496.107830834311, 10574.577016919236, 10708.19688523364, 176978.0, 178659.0, 178896.0, 179211.0, 179373.0, 39618.0, 39710.60289397127, 39819.0, 39834.60165398309, 39863.20273594512, 1222.9938850305691, 1273.2424207596466, 1275.1201670847086, 1282.0320657903223, 1297.6042307096238, 18170.90914545419, 18403.42352070738, 19244.422667320003, 19265.22939082421, 20035.799642003392, 30190.69809301879, 30284.0, 30343.696563034086, 30348.544771827997, 30392.0, 177339.0, 178112.0, 178549.0, 178629.0, 178915.10542447204, 27995.300117497227, 28044.29889252785, 28076.0, 28197.43605127927, 28214.576781348707, 24992.87503562543, 32528.51207231941, 32619.510707339883, 32962.50556241706, 33848.1537961553, 25157.0, 25165.496690066462, 25482.872585636953, 25620.745542949757, 26608.06871759479, 24624.0, 24812.52900000502, 25213.87393063023, 25292.36769080714, 25622.359441013377, 28533.571996419654, 28838.42323153483, 28867.711322886502, 28882.566761499016, 28925.7107428923, 24421.633675495235, 24561.140360087313, 24592.508149836543, 25105.24684259475, 25234.116805911704, 19409.902950485157, 20546.79453205449, 20588.69116963217, 20660.380188594365, 20799.216180278923], "value": 13979.28972165945, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.8818354493651, 398.7169109931948, 407.95512493625705, 408.28550037434485, 423.6970566045277, 17295.74056389152, 17881.284748610055, 18669.813301866976, 18678.78587891786, 18736.90631546842, 18073.1867065982, 18365.357212497565, 18441.53896152597, 18635.1614177362, 18659.813401865977, 5472.808451704182, 5534.584906132036, 5551.916721249185, 5598.076317407643, 5622.971885140569, 5425.728713564306, 5616.382197958222, 5616.943830561703, 5625.015622266107, 5626.831195064155, 5357.08929481989, 5479.589030822684, 5522.91715624266, 5593.944060559404, 5594.328680558338, 5439.129739241722, 5479.287692599936, 5519.061759500894, 5519.39286678465, 5524.226608274845, 4813.951860481386, 4841.685290456109, 4854.490278520775, 4854.951450485485, 4918.778654960535, 20790.0, 20878.895605521877, 20911.26810561623, 20970.0, 21091.367258982256, 1670.3068226686032, 1677.5973766296001, 1693.2380428807087, 1694.4747128390238, 1698.422536337651, 13984.300784960711, 14094.718105637932, 14173.78739318911, 14294.070885392417, 14322.427102915872, 2046.9385918422472, 2080.408487507043, 2133.5092928626345, 2133.8933053347428, 2138.625740495407, 78114.60942695307, 78722.21277787206, 78900.21099788987, 79966.60016699937, 80702.0, 10125.443100629389, 10271.0, 10575.36547807134, 10625.574977000988, 10661.413622250851, 14420.278986050656, 14533.200673963034, 14536.636584085483, 14561.635959100895, 14592.927035364968, 7054.753083642048, 7237.312455316736, 7332.120145582564, 7489.550626962399, 7513.549187048795, 6752.628605426748, 6798.592084474947, 6934.237233904267, 6944.895826562605, 6970.581765094111, 6684.966575167093, 6711.362420570038, 6741.831454213684, 6784.457243420613, 6843.931560684429, 1904.7142928560827, 1907.6852319367426, 1948.6067461764906, 1959.7256384106236, 1969.9606007879763, 828.7099515169763, 843.696269343036, 849.7748096754365, 867.6442658509981, 879.7492714576443, 15851.920740396456, 16714.58213544671, 16743.0, 16912.408065717642, 16932.915335423244, 885.9911400885909, 886.8758373827669, 898.5641963647626, 898.573177740568, 915.190056799737, 8778.542008237704, 9168.81662366749, 9175.678851240174, 9246.722598322061, 9323.533823308808, 481764.0, 486195.0, 487499.0, 489989.0, 491137.0, 73312.0, 80151.59924200458, 94958.52520737352, 96379.51810240904, 98042.0, 971.3783178765595, 1073.8979796919125, 1110.245033377311, 1114.8773634900153, 1116.2465335898237, 16449.25978330954, 16553.917230413772, 16907.746383804006, 17382.304707811545, 18007.279708812024, 43034.78482607567, 43379.78310108429, 43997.94023687189, 44386.55613443953, 45098.0980380384, 53155.0, 54093.72953135209, 54577.72711136419, 55630.16554751763, 55769.44230557805, 7422.777316680508, 7433.293837085468, 7454.0, 7468.4398670101045, 7782.182870798485, 11263.943680281875, 11578.594749183738, 11594.826077609012, 11800.82298765502, 12054.337011464453, 9883.308168428428, 10206.591736330463, 10270.281080324306, 10440.26918115755, 10664.466776661291, 9342.95328523353, 10077.143442807443, 10134.594616215269, 10204.132648724644, 10248.846267306146, 10083.546240419051, 10122.8481572775, 10144.239182061227, 10529.36823790575, 10579.15366770672, 7369.520981136209, 7371.115466144097, 7477.626118694152, 7609.581473019037, 7737.767866964, 10037.297389182979, 10123.89876101259, 10136.949315253376, 10186.745331366776, 10487.475626218506], "value": 8753.457931191904, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1289.3424353579674, 1349.4534713441053, 1352.7970804379347, 1361.4418088583677, 1371.122481611768, 9704.902950970489, 10144.391336519813, 10155.847662285072, 10161.441120738356, 10161.644342448017, 9961.2031037517, 10309.381437113778, 10311.175105991522, 10315.58737650495, 10316.0, 2323.9883800581015, 2355.5995480768224, 2366.479374537599, 2366.8106551475926, 2372.833901626887, 1928.3732786844262, 2003.47909543519, 2226.955460890781, 2333.6966194394704, 2342.2504798464497, 2235.8770267635273, 2322.686437330964, 2326.7905888470036, 2330.0446816805115, 2331.172433786007, 2219.3563866478703, 2277.601419751545, 2288.656701494781, 2291.576058429196, 2322.5354929014266, 2246.8651880887037, 2278.191242109044, 2282.1898226129815, 2282.8402011859175, 2286.0, 9907.702768916944, 10127.442990635513, 10137.189024878066, 10167.847482287772, 10175.643852465128, 5702.45826646468, 5905.4980326672285, 5907.232059832238, 5909.4090590941, 5915.615484993462, 3223.8549265282886, 3380.3746306933294, 3390.135515443571, 3459.117924929152, 3466.9479957800654, 1022.8363461846069, 1039.272509243525, 1058.3649810113948, 1077.6228320087985, 1094.7646256054907, 14911.776323355158, 15030.0, 15066.397344106223, 15072.0, 15072.397104115931, 4596.678232523691, 4768.260919557474, 4992.15133427311, 4995.700257984533, 5086.338775959101, 11060.834087488694, 11062.612808551823, 11089.944550277198, 11098.167637427225, 11103.38931358783, 5710.914336284959, 5722.055860782924, 5730.426957304319, 5730.713464326767, 5739.885202295931, 5165.845024649267, 5183.5593974512585, 5306.92039619406, 5307.363116426053, 5345.1714984177515, 3785.2618739346112, 3937.370020796659, 3948.7235893487755, 3998.280309544252, 4043.0, 1005.261133067195, 1051.5688567687212, 1164.9650510484698, 1166.5042356998242, 1180.144395313391, 645.3514218210762, 669.1267895396554, 674.4402146218627, 676.077154683853, 688.3770187979886, 5532.861678458071, 5586.469285417878, 5587.497125258747, 5650.23721797552, 5757.193992841006, 525.8159644124526, 562.5808772464541, 564.5370795947366, 568.8378812038632, 667.9799606011827, 3290.670932906738, 3617.1680513482047, 3627.782333060025, 3638.7634803737674, 3693.9445908311395, 12872.871271287355, 13536.864631353757, 13548.458061677422, 13568.796468052988, 13571.1857288563, 12941.805872911913, 13397.397117129753, 13400.128991615515, 13408.329583520785, 13424.865751342557, 9414.340996130206, 9559.61761529531, 9635.807283854283, 9637.18083962857, 9638.662646807328, 5461.726913654381, 5489.752961116679, 5521.199426083276, 5546.278983732089, 5657.632253903483, 11812.822807658064, 11834.82247766267, 11870.287782733063, 12023.21849079807, 12089.75820483603, 11784.175107742376, 12079.818802718142, 12246.203996740183, 12261.754764904474, 12267.0, 8243.587820609066, 8272.627731751965, 8388.622511986854, 8406.83186336282, 8471.915280847114, 8922.286217102486, 9129.5891684873, 9131.680391186277, 9139.44629412988, 9140.0, 7981.92018079835, 8123.75628731139, 8128.837423251383, 8272.33821294283, 8374.581270936307, 7680.5391676499585, 7719.266669666373, 7884.605769711607, 7961.283484486424, 7993.080795708568, 7342.8898566520475, 7345.816354591178, 7372.668229929559, 7427.405807535492, 7454.552726836408, 5085.694858308365, 5176.145935920531, 5202.297689811827, 5232.921506177487, 5289.259503669412, 5054.09026375256, 5054.772535235849, 5117.543579081987, 5279.47205279469, 5284.233786101071], "value": 4732.390308652212, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.38630294257115, 376.8662124945644, 379.7626483447845, 383.61063520526653, 384.52703175094615, 5345.812896548621, 5346.919796203055, 5360.115580929152, 5365.543928766059, 5397.91903121453, 5060.949390506094, 5202.739863006854, 5256.973715131419, 5265.9473405265935, 5300.151975683892, 4007.218592374481, 4011.1777085697363, 4011.879643610682, 4013.8394464221396, 4033.2336855997414, 3977.741446805963, 4005.118873847749, 4010.4585880906143, 4012.2577323195155, 4020.356742921133, 3863.3239183142978, 3975.403689446577, 3977.781222032787, 3997.240524300388, 4009.9799501002453, 3938.601796362279, 3978.6021397860272, 3980.3631418972827, 3988.4615576897036, 3990.880273591797, 3477.930441391183, 3480.3735327641016, 3485.7559970802054, 3490.661256957844, 3496.370653282408, 4814.542618451242, 5086.18621020635, 5097.643164978453, 5103.18349064148, 5106.387233531963, 4605.976970115162, 4659.930101048487, 4668.299755036738, 4680.836170734008, 4688.390509233812, 5528.668279903219, 5535.6955367454775, 5579.302587176603, 5595.468430499096, 5608.691521966291, 3793.4878791363367, 3885.805709714531, 3888.2891527727993, 3893.552241492236, 3898.6686131678557, 5626.76211233528, 5754.625949313281, 5785.797497087582, 5852.707364631751, 5887.705614719247, 3980.8407663693706, 3981.5819338969573, 3981.980090099531, 3986.262541429787, 3986.7807270600397, 4030.314846476106, 4042.0097076216516, 4042.7372220805555, 4043.0903046814233, 4044.2518134145275, 4441.666874984389, 4538.523455037173, 4652.767361631905, 4774.427068751772, 4851.296561998491, 5608.6073974821375, 5618.69097199658, 5623.831285061373, 5629.155626656035, 5630.662160270315, 1475.76387777955, 1494.618872187607, 1497.1466264229284, 1497.4160077569757, 1497.4983380567414, 1038.4963292802984, 1064.2869277584036, 1072.110148576695, 1072.4584085037006, 1087.7273589899837, 4874.268859671007, 4884.95115048852, 4889.657723959289, 4892.363992680928, 4900.656954013185, 5774.249347584787, 5776.104703770922, 5785.392533783892, 5788.652680839163, 5789.0, 4748.548887855648, 4875.609951203895, 4893.4617192108835, 4899.804007839646, 4908.410990681141, 3028.9242768930953, 3043.786934914579, 3055.312554675225, 3057.816531008102, 3078.615173103362, 5273.815416460482, 5396.541293989976, 5405.70268635221, 5406.459354064562, 5425.213344065168, 5872.884152011105, 5888.352281249059, 5905.557083218776, 5910.556708246899, 5913.645181289136, 5388.8113916013535, 5389.434109418533, 5402.6758394496455, 5408.215808707637, 5445.074337362737, 5525.889482210414, 5677.51741102011, 5680.68756218412, 5706.771729130788, 5734.569907257056, 5669.036263835075, 5669.20631111653, 5708.915306091829, 5710.200571920018, 5713.371529131709, 5195.376554813447, 5222.8955420892125, 5298.947010529845, 5323.760430780547, 5400.513953744182, 4192.496900371975, 4193.517745459311, 4201.138766552788, 4225.66194704429, 4241.681873859411, 5552.916706249329, 5700.600957932905, 5724.8282551523525, 5738.8278351649515, 5759.280089988752, 5555.111182210827, 5572.60991730575, 5575.972120139373, 5583.274174357308, 5585.0, 5552.083906155601, 5554.166874968787, 5561.833145005657, 5588.189712491585, 5592.189132575835, 5287.206918962186, 5463.808766693147, 5476.397596264487, 5491.615586908878, 5499.752511136929, 5593.8042168525535, 5607.607467477237, 5609.102543593006, 5610.8316750495915, 5613.382527921844, 5372.059889519241, 5426.996005738951, 5445.754941027584, 5470.015397228537, 5470.550304169319], "value": 4202.615261689227, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [734.3354264390725, 743.7657138001525, 752.8795392737163, 755.210804709079, 767.4321002458181, 12858.742825143492, 13131.0, 13417.262050587215, 13428.932855335734, 13434.59696209113, 12295.139340246187, 12534.435950382232, 12535.749285014293, 12538.81191782124, 12788.104832661717, 892.5269607108243, 904.1500989070253, 910.8497097978826, 915.3592485260311, 916.3448134583771, 934.9948805034581, 935.2658163341778, 935.4387367579432, 936.9250459963221, 937.1986951156765, 965.1844191658038, 965.6861520006026, 965.7102869139266, 965.7344230336644, 966.5843687214496, 955.3551352836807, 957.238994998974, 958.4584709639032, 960.1262850805733, 963.8891527474325, 706.9116360454943, 712.0778591723679, 712.5154894671621, 713.375796178344, 714.9642517874086, 13692.863071369358, 13891.0, 14051.859481405158, 14069.859301406957, 14084.15495070299, 12430.937845310715, 13160.341982900816, 13371.130876493095, 13398.665033374145, 13489.932550337284, 11414.258073225214, 11659.766804663945, 11763.529458821637, 11771.0, 11868.821967670492, 2851.0876519513763, 2858.4568931902872, 2866.2977570495154, 2883.5818806272973, 2889.0754958413318, 70000.2999970004, 70529.6473517629, 70532.0, 72330.0, 72928.0, 11102.999999999838, 11110.666679999613, 11137.51379512629, 11153.665390038312, 11497.885021149848, 21355.8932205338, 21566.245181418573, 21579.13683452644, 21597.572497637946, 21641.56716865654, 5546.639468434539, 5698.230738850285, 5755.840323778486, 5801.767929282782, 5816.0, 2840.176348858849, 2850.8717107730204, 2871.5118429866975, 2971.6731159572428, 2979.031814660244, 3520.823958802101, 3613.2050948791225, 3644.526211592529, 3645.4714066460215, 3648.7263455240964, 644.1851058411114, 650.4698670583459, 654.2639530528156, 656.8981807819796, 657.4477438951304, 508.62870104822946, 511.40166005773335, 519.8310549071567, 522.276646844116, 525.8711615654189, 7410.703571857065, 7652.349550288177, 7675.15573286938, 7800.0, 7867.527948323119, 521.0984995957016, 523.9004589128053, 527.6069328350403, 531.4871149340827, 540.8593765620889, 3474.2009337851932, 3514.086337552255, 3551.964480355215, 3558.665500437336, 3731.2910546995986, 57701.71149144227, 59262.40737592655, 59852.40147598468, 62303.37696622976, 62305.688471557354, 52147.73926130345, 52741.208881866805, 52992.73503632457, 53019.0, 54355.72822135943, 35124.82437587796, 46653.0, 48502.757486212344, 49245.75377123091, 49454.0, 9115.544222788967, 9448.763780905532, 9592.66425675098, 9598.136167744937, 9636.132748052709, 27111.59332610052, 27181.72818271792, 27526.587101193098, 27617.309567260978, 27773.583396249476, 32225.355492889543, 32327.191820204684, 32428.675713242566, 32679.346413072082, 33719.66280337263, 10376.948115259376, 10390.636327728796, 10541.78916421652, 10591.682249532527, 10796.190285728444, 10419.843702344318, 10422.635207767995, 10423.635172768916, 10454.215933804842, 10479.68560943173, 11964.341961192218, 11979.161458697807, 11993.220440671328, 12109.757804843677, 12110.697232569257, 11279.9213028748, 11656.475458604553, 11723.35521546289, 11905.880941190824, 12133.575324863587, 11798.196586928776, 11972.281663100242, 12099.758004839678, 12197.0, 12882.355882205664, 9397.906020939703, 9755.170810481188, 9816.754581135528, 9827.606895724091, 9938.503074846085, 9502.0, 9986.800263994824, 10043.347182433119, 10050.447225402673, 10129.290949633749], "value": 6270.023566959638, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1538.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 113.0, 112.0, 112.0, 112.0, 114.0, 113.0, 112.0, 112.0, 112.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 125.0, 129.0, 162.0, 124.0, 123.0, 122.0, 132.0, 145.0, 123.0], "value": 134.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 165.0, 165.0, 165.0, 165.0, 163.0, 165.0, 162.0, 163.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 112.0, 79.0, 76.0, 76.0, 75.0, 91.0, 75.0], "value": 80.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 106.0, 83.0, 84.0, 83.0, 106.0, 84.0, 84.0, 106.0], "value": 90.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 113.0, 113.0, 113.0, 114.0, 114.0, 114.0, 114.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 151.0, 151.0, 150.0, 151.0, 151.0, 151.0, 152.0, 151.0], "value": 151.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 94.0, 94.0, 95.0, 95.0, 95.0, 94.0, 111.0, 95.0], "value": 96.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 52.0, 54.0, 53.0, 54.0, 55.0, 54.0, 54.0, 53.0], "value": 53.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 57.0, 56.0, 56.0, 56.0, 57.0, 56.0, 56.0, 62.0], "value": 56.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 83.0, 83.0, 88.0, 82.0, 83.0, 83.0, 83.0, 83.0], "value": 83.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 133.0, 134.0, 132.0, 133.0, 139.0, 134.0, 135.0, 182.0, 138.0], "value": 139.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 191.0, 192.0, 192.0, 191.0, 191.0, 194.0, 195.0, 194.0, 192.0], "value": 191.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 71.0, 72.0, 74.0, 74.0, 69.0, 70.0, 69.0, 70.0, 71.0], "value": 71.5, "unit": "score"}]}]} 22:28:27 INFO - Return code: 0 22:28:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:28:27 ERROR - # TBPL SUCCESS # 22:28:27 INFO - Running post-action listener: _resource_record_post_action 22:28:27 INFO - [mozharness: 2017-04-06 05:28:27.111002Z] Finished run-tests step (success) 22:28:27 INFO - Running post-run listener: _resource_record_post_run 22:28:27 INFO - Total resource usage - Wall time: 1206s; CPU: 13.0%; Read bytes: 12288; Write bytes: 356089856; Read time: 244; Write time: 241040 22:28:27 INFO - TinderboxPrint: CPU usage
13.0% 22:28:27 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 244 22:28:27 INFO - TinderboxPrint: I/O write bytes / time
356,089,856 / 241,040 22:28:27 INFO - TinderboxPrint: CPU idle
8,371.9 (87.0%) 22:28:27 INFO - TinderboxPrint: CPU user
1,205.8 (12.5%) 22:28:27 INFO - TinderboxPrint: Swap in / out
0 / 0 22:28:27 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 102813696; Read time: 0; Write time: 111248 22:28:27 INFO - run-tests - Wall time: 1191s; CPU: 13.0%; Read bytes: 8192; Write bytes: 252739584; Read time: 228; Write time: 129792 22:28:27 INFO - Running post-run listener: _upload_blobber_files 22:28:27 INFO - Blob upload gear active. 22:28:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:28:27 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 22:28:27 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:28:27 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:28:28 INFO - (blobuploader) - INFO - Open directory for files ... 22:28:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 22:28:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:28:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:28:28 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 22:28:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:28:28 INFO - (blobuploader) - INFO - Done attempting. 22:28:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:28:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:28:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:28:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:28:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:28:29 INFO - (blobuploader) - INFO - Done attempting. 22:28:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:28:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:28:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:28:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:28:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:28:30 INFO - (blobuploader) - INFO - Done attempting. 22:28:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:28:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:28:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:28:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:28:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:28:33 INFO - (blobuploader) - INFO - Done attempting. 22:28:33 INFO - (blobuploader) - INFO - Iteration through files over. 22:28:33 INFO - Return code: 0 22:28:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:28:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:28:33 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/89ffff53043b26d6a4b0960c7b09c27581c7e8fefc87734553f1ecb12725f4b9e0bbd74e9beaba45cd4dbf096438e1a18f1b9e84c3e6e528556e414de487e885", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/18abf4634e5e321a2d06c4e7e8ee74f7d691ef17e14e5e546521225f4a08ae38f0f8b7dfba74fd4dec0487d3cb83fecfaefef61862422aeb8467b221b0b760c0", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/017dab8fcc8025e191d772cf7e0b282a25a20db2771467081f26de9db447d0b60b799d7d3bf2d8cf107b154fa01eec85bff80cdcad74e42293774fee13e39a60", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e9f36a98daea15d40c3486f8798db8118184ea5e259df38aff07cd6888476dd6b534889474a57422e32d91ee86fd39e0c9da737f4f5cb267eda7ad4a476cb45"} 22:28:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:28:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:28:33 INFO - Contents: 22:28:33 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/89ffff53043b26d6a4b0960c7b09c27581c7e8fefc87734553f1ecb12725f4b9e0bbd74e9beaba45cd4dbf096438e1a18f1b9e84c3e6e528556e414de487e885", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/18abf4634e5e321a2d06c4e7e8ee74f7d691ef17e14e5e546521225f4a08ae38f0f8b7dfba74fd4dec0487d3cb83fecfaefef61862422aeb8467b221b0b760c0", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/017dab8fcc8025e191d772cf7e0b282a25a20db2771467081f26de9db447d0b60b799d7d3bf2d8cf107b154fa01eec85bff80cdcad74e42293774fee13e39a60", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e9f36a98daea15d40c3486f8798db8118184ea5e259df38aff07cd6888476dd6b534889474a57422e32d91ee86fd39e0c9da737f4f5cb267eda7ad4a476cb45"} 22:28:33 INFO - Running post-run listener: copy_logs_to_upload_dir 22:28:33 INFO - Copying logs to upload dir... 22:28:33 INFO - mkdir: /builds/slave/test/build/upload/logs 22:28:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.673391 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-04-05 22:28:33.640621) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-05 22:28:33.644174) ========= 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=14ef55db36f7623abb31b9cf000001d5-1491455248.489998-1886381097 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/89ffff53043b26d6a4b0960c7b09c27581c7e8fefc87734553f1ecb12725f4b9e0bbd74e9beaba45cd4dbf096438e1a18f1b9e84c3e6e528556e414de487e885", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/18abf4634e5e321a2d06c4e7e8ee74f7d691ef17e14e5e546521225f4a08ae38f0f8b7dfba74fd4dec0487d3cb83fecfaefef61862422aeb8467b221b0b760c0", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/017dab8fcc8025e191d772cf7e0b282a25a20db2771467081f26de9db447d0b60b799d7d3bf2d8cf107b154fa01eec85bff80cdcad74e42293774fee13e39a60", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e9f36a98daea15d40c3486f8798db8118184ea5e259df38aff07cd6888476dd6b534889474a57422e32d91ee86fd39e0c9da737f4f5cb267eda7ad4a476cb45"} build_url:https://queue.taskcluster.net/v1/task/Vnyo5g2vT3O3SBVrvvZGXA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011314 build_url: 'https://queue.taskcluster.net/v1/task/Vnyo5g2vT3O3SBVrvvZGXA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/89ffff53043b26d6a4b0960c7b09c27581c7e8fefc87734553f1ecb12725f4b9e0bbd74e9beaba45cd4dbf096438e1a18f1b9e84c3e6e528556e414de487e885", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/18abf4634e5e321a2d06c4e7e8ee74f7d691ef17e14e5e546521225f4a08ae38f0f8b7dfba74fd4dec0487d3cb83fecfaefef61862422aeb8467b221b0b760c0", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/017dab8fcc8025e191d772cf7e0b282a25a20db2771467081f26de9db447d0b60b799d7d3bf2d8cf107b154fa01eec85bff80cdcad74e42293774fee13e39a60", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e9f36a98daea15d40c3486f8798db8118184ea5e259df38aff07cd6888476dd6b534889474a57422e32d91ee86fd39e0c9da737f4f5cb267eda7ad4a476cb45"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-05 22:28:33.669788) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 22:28:33.670148) ========= 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=14ef55db36f7623abb31b9cf000001d5-1491455248.489998-1886381097 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004370 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 22:28:33.753864) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-05 22:28:33.754183) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-05 22:28:33.754490) ========= ========= Total master_lag: 0.17 =========